builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1465814379.24 results: success (0) buildid: 20160613005326 builduid: 4f35cbfd68ad473a8988e38b91f3cd81 revision: 1a585c67e88e31e89aa165f6b706600a2ef92386 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.242720) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.243118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.243390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.306027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.306309) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 03:39:39-- 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% 21.3M=0.001s 2016-06-13 03:39:39 (21.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.440731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.441022) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017312 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.489922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:39.490242) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a585c67e88e31e89aa165f6b706600a2ef92386 --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 1a585c67e88e31e89aa165f6b706600a2ef92386 --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=6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 03:39:39,811 truncating revision to first 12 chars 2016-06-13 03:39:39,811 Setting DEBUG logging. 2016-06-13 03:39:39,811 attempt 1/10 2016-06-13 03:39:39,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a585c67e88e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 03:39:40,137 unpacking tar archive at: mozilla-aurora-1a585c67e88e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:40.185102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:40.185413) ========= script_repo_revision: 1a585c67e88e31e89aa165f6b706600a2ef92386 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:40.185842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:40.189212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 03:39:40.200103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-13 03:39:40.200486) ========= /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=6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:40 INFO - MultiFileLogger online at 20160613 03:39:40 in /builds/slave/test 03:39:40 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:39:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:40 INFO - {'append_to_log': False, 03:39:40 INFO - 'base_work_dir': '/builds/slave/test', 03:39:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:40 INFO - 'branch': 'Mozilla-Aurora', 03:39:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:40 INFO - 'config_files': ('talos/linux_config.py',), 03:39:40 INFO - 'default_actions': ('clobber', 03:39:40 INFO - 'read-buildbot-config', 03:39:40 INFO - 'download-and-extract', 03:39:40 INFO - 'populate-webroot', 03:39:40 INFO - 'create-virtualenv', 03:39:40 INFO - 'install', 03:39:40 INFO - 'run-tests'), 03:39:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:40 INFO - 'download_minidump_stackwalk': True, 03:39:40 INFO - 'download_symbols': 'ondemand', 03:39:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:40 INFO - 'installer_path': 'installer.exe', 03:39:40 INFO - 'log_level': 'info', 03:39:40 INFO - 'log_name': 'talos', 03:39:40 INFO - 'log_to_console': True, 03:39:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:40 INFO - 'opt_config_files': (), 03:39:40 INFO - 'pip_index': False, 03:39:40 INFO - 'sps_profile': False, 03:39:40 INFO - 'sps_profile_interval': 0, 03:39:40 INFO - 'suite': 'dromaeojs', 03:39:40 INFO - 'system_bits': '32', 03:39:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:40 INFO - 'title': 'talos-linux64-ix-023', 03:39:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:40 INFO - 'use_talos_json': True, 03:39:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:40 INFO - 'work_dir': 'build'} 03:39:40 INFO - ##### 03:39:40 INFO - ##### Running clobber step. 03:39:40 INFO - ##### 03:39:40 INFO - Running pre-action listener: _resource_record_pre_action 03:39:40 INFO - Running main action method: clobber 03:39:40 INFO - rmtree: /builds/slave/test/build 03:39:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:41 INFO - Running post-action listener: _resource_record_post_action 03:39:41 INFO - ##### 03:39:41 INFO - ##### Finished clobber step (success) 03:39:41 INFO - ##### 03:39:41 INFO - ##### 03:39:41 INFO - ##### Running read-buildbot-config step. 03:39:41 INFO - ##### 03:39:41 INFO - Running pre-action listener: _resource_record_pre_action 03:39:41 INFO - Running main action method: read_buildbot_config 03:39:41 INFO - Using buildbot properties: 03:39:41 INFO - { 03:39:41 INFO - "project": "", 03:39:41 INFO - "product": "firefox", 03:39:41 INFO - "script_repo_revision": "production", 03:39:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:39:41 INFO - "repository": "", 03:39:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:39:41 INFO - "buildid": "20160613005326", 03:39:41 INFO - "pgo_build": "True", 03:39:41 INFO - "basedir": "/builds/slave/test", 03:39:41 INFO - "buildnumber": 564, 03:39:41 INFO - "slavename": "talos-linux64-ix-023", 03:39:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:39:41 INFO - "platform": "ubuntu64_hw", 03:39:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:41 INFO - "branch": "mozilla-aurora", 03:39:41 INFO - "repo_path": "releases/mozilla-aurora", 03:39:41 INFO - "revision": "1a585c67e88e31e89aa165f6b706600a2ef92386", 03:39:41 INFO - "stage_platform": "linux64-pgo", 03:39:41 INFO - "builduid": "4f35cbfd68ad473a8988e38b91f3cd81", 03:39:41 INFO - "slavebuilddir": "test" 03:39:41 INFO - } 03:39:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:39:41 INFO - Running post-action listener: _resource_record_post_action 03:39:41 INFO - ##### 03:39:41 INFO - ##### Finished read-buildbot-config step (success) 03:39:41 INFO - ##### 03:39:41 INFO - ##### 03:39:41 INFO - ##### Running download-and-extract step. 03:39:41 INFO - ##### 03:39:41 INFO - Running pre-action listener: _resource_record_pre_action 03:39:41 INFO - Running main action method: download_and_extract 03:39:41 INFO - mkdir: /builds/slave/test/build/tests 03:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:41 INFO - https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:39:50 INFO - Downloaded 1361 bytes. 03:39:50 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:39:50 INFO - Using the following test package requirements: 03:39:50 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:50 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:50 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:39:50 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'jsshell-linux-x86_64.zip'], 03:39:50 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:50 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:50 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:50 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:50 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:50 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:50 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39:50 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:39:50 INFO - https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:39:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:39:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:39:57 INFO - Downloaded 24473803 bytes. 03:39:57 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:39:57 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:39:59 INFO - Return code: 0 03:39:59 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:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:59 INFO - https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:39:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:39:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:40:00 INFO - Downloaded 24473803 bytes. 03:40:00 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:40:00 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:40:02 INFO - Return code: 0 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:02 INFO - https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:40:03 INFO - Downloaded 10833369 bytes. 03:40:03 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:40:03 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:40:03 INFO - Return code: 0 03:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:03 INFO - https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:40:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6xBeWcARfG8Upi6by5mTQ/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:40:05 INFO - Downloaded 63561209 bytes. 03:40:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:05 INFO - mkdir: /builds/slave/test/properties 03:40:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:05 INFO - Contents: 03:40:05 INFO - build_url:https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:40:06 INFO - Running post-action listener: _resource_record_post_action 03:40:06 INFO - Running post-action listener: set_extra_try_arguments 03:40:06 INFO - ##### 03:40:06 INFO - ##### Finished download-and-extract step (success) 03:40:06 INFO - ##### 03:40:06 INFO - ##### 03:40:06 INFO - ##### Running populate-webroot step. 03:40:06 INFO - ##### 03:40:06 INFO - Running pre-action listener: _resource_record_pre_action 03:40:06 INFO - Running main action method: populate_webroot 03:40:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:06 INFO - '--tppagecycles', 03:40:06 INFO - '7'], 03:40:06 INFO - 'tests': ['tsvgm']}}, 03:40:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['damp', 'tps']}, 03:40:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'tests': ['damp', 'tps']}, 03:40:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['dromaeo_dom']}, 03:40:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tsvgx', 03:40:06 INFO - 'tsvgr_opacity', 03:40:06 INFO - 'tart', 03:40:06 INFO - 'tscrollx', 03:40:06 INFO - 'cart']}, 03:40:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:06 INFO - 'tsvgr_opacity', 03:40:06 INFO - 'tart', 03:40:06 INFO - 'tscrollx', 03:40:06 INFO - 'cart']}, 03:40:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tp5o']}, 03:40:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'tests': ['tp5o']}, 03:40:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s', 03:40:06 INFO - '--xperf_path', 03:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:06 INFO - 'tests': ['tp5n']}, 03:40:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:06 INFO - 'talos_options': ['--xperf_path', 03:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:06 INFO - 'tests': ['tp5n']}}, 03:40:06 INFO - 'talos.zip': {'path': '', 03:40:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:06 INFO - Running post-action listener: _resource_record_post_action 03:40:06 INFO - ##### 03:40:06 INFO - ##### Finished populate-webroot step (success) 03:40:06 INFO - ##### 03:40:06 INFO - ##### 03:40:06 INFO - ##### Running create-virtualenv step. 03:40:06 INFO - ##### 03:40:06 INFO - Running pre-action listener: _resource_record_pre_action 03:40:06 INFO - Running main action method: create_virtualenv 03:40:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:06 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:40:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:06 INFO - Using real prefix '/usr' 03:40:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:08 INFO - Installing pip.................done. 03:40:08 INFO - Return code: 0 03:40:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:09 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:40:09 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:40:09 INFO - Using env: {'DISPLAY': ':0', 03:40:09 INFO - 'HOME': '/home/cltbld', 03:40:09 INFO - 'LANG': 'en_US.UTF-8', 03:40:09 INFO - 'LANGUAGE': 'en_US:en', 03:40:09 INFO - 'LOGNAME': 'cltbld', 03:40:09 INFO - 'MAIL': '/var/mail/cltbld', 03:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:09 INFO - 'MOZ_NO_REMOTE': '1', 03:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:09 INFO - 'NO_EM_RESTART': '1', 03:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:09 INFO - 'PWD': '/builds/slave/test', 03:40:09 INFO - 'SHELL': '/bin/bash', 03:40:09 INFO - 'SHLVL': '1', 03:40:09 INFO - 'TERM': 'linux', 03:40:09 INFO - 'TMOUT': '86400', 03:40:09 INFO - 'USER': 'cltbld', 03:40:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:09 INFO - '_': '/tools/buildbot/bin/python'} 03:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:09 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:40:09 INFO - Cleaning up... 03:40:09 INFO - Return code: 0 03:40:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:40:09 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:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:09 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:40:09 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:40:09 INFO - Using env: {'DISPLAY': ':0', 03:40:09 INFO - 'HOME': '/home/cltbld', 03:40:09 INFO - 'LANG': 'en_US.UTF-8', 03:40:09 INFO - 'LANGUAGE': 'en_US:en', 03:40:09 INFO - 'LOGNAME': 'cltbld', 03:40:09 INFO - 'MAIL': '/var/mail/cltbld', 03:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:09 INFO - 'MOZ_NO_REMOTE': '1', 03:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:09 INFO - 'NO_EM_RESTART': '1', 03:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:09 INFO - 'PWD': '/builds/slave/test', 03:40:09 INFO - 'SHELL': '/bin/bash', 03:40:09 INFO - 'SHLVL': '1', 03:40:09 INFO - 'TERM': 'linux', 03:40:09 INFO - 'TMOUT': '86400', 03:40:09 INFO - 'USER': 'cltbld', 03:40:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:09 INFO - '_': '/tools/buildbot/bin/python'} 03:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:09 INFO - Downloading/unpacking psutil>=3.1.1 03:40:09 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:40:09 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:40:09 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:40:09 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:40:09 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:40:09 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:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:11 INFO - Installing collected packages: psutil 03:40:11 INFO - Running setup.py install for psutil 03:40:11 INFO - building 'psutil._psutil_linux' extension 03:40:11 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:40:11 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:40:11 INFO - building 'psutil._psutil_posix' extension 03:40:11 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:40:11 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:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:11 INFO - Successfully installed psutil 03:40:11 INFO - Cleaning up... 03:40:12 INFO - Return code: 0 03:40:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:12 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:12 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:40:12 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:40:12 INFO - Using env: {'DISPLAY': ':0', 03:40:12 INFO - 'HOME': '/home/cltbld', 03:40:12 INFO - 'LANG': 'en_US.UTF-8', 03:40:12 INFO - 'LANGUAGE': 'en_US:en', 03:40:12 INFO - 'LOGNAME': 'cltbld', 03:40:12 INFO - 'MAIL': '/var/mail/cltbld', 03:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:12 INFO - 'MOZ_NO_REMOTE': '1', 03:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:12 INFO - 'NO_EM_RESTART': '1', 03:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:12 INFO - 'PWD': '/builds/slave/test', 03:40:12 INFO - 'SHELL': '/bin/bash', 03:40:12 INFO - 'SHLVL': '1', 03:40:12 INFO - 'TERM': 'linux', 03:40:12 INFO - 'TMOUT': '86400', 03:40:12 INFO - 'USER': 'cltbld', 03:40:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:12 INFO - '_': '/tools/buildbot/bin/python'} 03:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:12 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:40:12 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:40:12 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:40:12 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:40:12 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:40:12 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:40:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:14 INFO - Installing collected packages: mozsystemmonitor 03:40:14 INFO - Running setup.py install for mozsystemmonitor 03:40:14 INFO - Successfully installed mozsystemmonitor 03:40:14 INFO - Cleaning up... 03:40:14 INFO - Return code: 0 03:40:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:14 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:40:14 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:40:14 INFO - Using env: {'DISPLAY': ':0', 03:40:14 INFO - 'HOME': '/home/cltbld', 03:40:14 INFO - 'LANG': 'en_US.UTF-8', 03:40:14 INFO - 'LANGUAGE': 'en_US:en', 03:40:14 INFO - 'LOGNAME': 'cltbld', 03:40:14 INFO - 'MAIL': '/var/mail/cltbld', 03:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:14 INFO - 'MOZ_NO_REMOTE': '1', 03:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:14 INFO - 'NO_EM_RESTART': '1', 03:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:14 INFO - 'PWD': '/builds/slave/test', 03:40:14 INFO - 'SHELL': '/bin/bash', 03:40:14 INFO - 'SHLVL': '1', 03:40:14 INFO - 'TERM': 'linux', 03:40:14 INFO - 'TMOUT': '86400', 03:40:14 INFO - 'USER': 'cltbld', 03:40:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:14 INFO - '_': '/tools/buildbot/bin/python'} 03:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:40:14 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:40:14 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:40:14 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:40:14 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:40:14 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:40:14 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:40:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40:16 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:40:16 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:40:16 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:40:16 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:40:16 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:40:16 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:40:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:16 INFO - warning: no files found matching '*.txt' 03:40:16 INFO - no previously-included directories found matching 'build' 03:40:16 INFO - no previously-included directories found matching 'dist' 03:40:16 INFO - no previously-included directories found matching '.git*' 03:40:16 INFO - Installing collected packages: jsonschema, functools32 03:40:16 INFO - Running setup.py install for functools32 03:40:16 INFO - warning: no files found matching '*.txt' 03:40:16 INFO - no previously-included directories found matching 'build' 03:40:16 INFO - no previously-included directories found matching 'dist' 03:40:16 INFO - no previously-included directories found matching '.git*' 03:40:16 INFO - Successfully installed jsonschema functools32 03:40:16 INFO - Cleaning up... 03:40:16 INFO - Return code: 0 03:40:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:16 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:16 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:40:16 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:40:16 INFO - Using env: {'DISPLAY': ':0', 03:40:16 INFO - 'HOME': '/home/cltbld', 03:40:16 INFO - 'LANG': 'en_US.UTF-8', 03:40:16 INFO - 'LANGUAGE': 'en_US:en', 03:40:16 INFO - 'LOGNAME': 'cltbld', 03:40:16 INFO - 'MAIL': '/var/mail/cltbld', 03:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:16 INFO - 'MOZ_NO_REMOTE': '1', 03:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:16 INFO - 'NO_EM_RESTART': '1', 03:40:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:16 INFO - 'PWD': '/builds/slave/test', 03:40:16 INFO - 'SHELL': '/bin/bash', 03:40:16 INFO - 'SHLVL': '1', 03:40:16 INFO - 'TERM': 'linux', 03:40:16 INFO - 'TMOUT': '86400', 03:40:16 INFO - 'USER': 'cltbld', 03:40:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:16 INFO - '_': '/tools/buildbot/bin/python'} 03:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:19 INFO - Downloading docopt-0.6.1.tar.gz 03:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:19 INFO - Running setup.py install for blobuploader 03:40:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:19 INFO - Running setup.py install for requests 03:40:20 INFO - Running setup.py install for docopt 03:40:20 INFO - Successfully installed blobuploader requests docopt 03:40:20 INFO - Cleaning up... 03:40:20 INFO - Return code: 0 03:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:20 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:20 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:40:20 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:40:20 INFO - Using env: {'DISPLAY': ':0', 03:40:20 INFO - 'HOME': '/home/cltbld', 03:40:20 INFO - 'LANG': 'en_US.UTF-8', 03:40:20 INFO - 'LANGUAGE': 'en_US:en', 03:40:20 INFO - 'LOGNAME': 'cltbld', 03:40:20 INFO - 'MAIL': '/var/mail/cltbld', 03:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:20 INFO - 'MOZ_NO_REMOTE': '1', 03:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:20 INFO - 'NO_EM_RESTART': '1', 03:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:20 INFO - 'PWD': '/builds/slave/test', 03:40:20 INFO - 'SHELL': '/bin/bash', 03:40:20 INFO - 'SHLVL': '1', 03:40:20 INFO - 'TERM': 'linux', 03:40:20 INFO - 'TMOUT': '86400', 03:40:20 INFO - 'USER': 'cltbld', 03:40:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:20 INFO - '_': '/tools/buildbot/bin/python'} 03:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:20 INFO - Running setup.py (path:/tmp/pip-lnv9Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:20 INFO - Running setup.py (path:/tmp/pip-cSh3SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:20 INFO - Running setup.py (path:/tmp/pip-RGbzpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:20 INFO - Running setup.py (path:/tmp/pip-ujJG4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:20 INFO - Running setup.py (path:/tmp/pip-CAAzqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:20 INFO - Running setup.py (path:/tmp/pip-gq_yrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:21 INFO - Running setup.py (path:/tmp/pip-AQjdi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:21 INFO - Running setup.py (path:/tmp/pip-xfqDCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:21 INFO - Running setup.py (path:/tmp/pip-wDi3sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:21 INFO - Running setup.py (path:/tmp/pip-1XNWBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:21 INFO - Running setup.py (path:/tmp/pip-Nsyp6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:21 INFO - Running setup.py (path:/tmp/pip-nT4jYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:21 INFO - Running setup.py (path:/tmp/pip-1JBEHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:21 INFO - Running setup.py (path:/tmp/pip-7Tce_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:21 INFO - Running setup.py (path:/tmp/pip-w3nifp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:21 INFO - Running setup.py (path:/tmp/pip-tlFDuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:21 INFO - Running setup.py (path:/tmp/pip-FV0uOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:21 INFO - Running setup.py install for manifestparser 03:40:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:21 INFO - Running setup.py install for mozcrash 03:40:22 INFO - Running setup.py install for mozdebug 03:40:22 INFO - Running setup.py install for mozdevice 03:40:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Running setup.py install for mozfile 03:40:22 INFO - Running setup.py install for mozhttpd 03:40:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Running setup.py install for mozinfo 03:40:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Running setup.py install for mozInstall 03:40:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Running setup.py install for mozleak 03:40:22 INFO - Running setup.py install for mozlog 03:40:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Running setup.py install for moznetwork 03:40:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:22 INFO - Running setup.py install for mozprocess 03:40:23 INFO - Running setup.py install for mozprofile 03:40:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:23 INFO - Running setup.py install for mozrunner 03:40:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:23 INFO - Running setup.py install for mozscreenshot 03:40:23 INFO - Running setup.py install for moztest 03:40:23 INFO - Running setup.py install for mozversion 03:40:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:23 INFO - Cleaning up... 03:40:23 INFO - Return code: 0 03:40:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:23 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:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:23 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:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:23 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:23 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:40:23 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:40:23 INFO - Using env: {'DISPLAY': ':0', 03:40:23 INFO - 'HOME': '/home/cltbld', 03:40:23 INFO - 'LANG': 'en_US.UTF-8', 03:40:23 INFO - 'LANGUAGE': 'en_US:en', 03:40:23 INFO - 'LOGNAME': 'cltbld', 03:40:23 INFO - 'MAIL': '/var/mail/cltbld', 03:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:23 INFO - 'MOZ_NO_REMOTE': '1', 03:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:23 INFO - 'NO_EM_RESTART': '1', 03:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:23 INFO - 'PWD': '/builds/slave/test', 03:40:23 INFO - 'SHELL': '/bin/bash', 03:40:23 INFO - 'SHLVL': '1', 03:40:23 INFO - 'TERM': 'linux', 03:40:23 INFO - 'TMOUT': '86400', 03:40:23 INFO - 'USER': 'cltbld', 03:40:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:23 INFO - '_': '/tools/buildbot/bin/python'} 03:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:23 INFO - Running setup.py (path:/tmp/pip-6c1Oer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:23 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:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:23 INFO - Running setup.py (path:/tmp/pip-1YruRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:23 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:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:23 INFO - Running setup.py (path:/tmp/pip-nUkWYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:24 INFO - Running setup.py (path:/tmp/pip-CY1uvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:24 INFO - Running setup.py (path:/tmp/pip-c1SMjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:24 INFO - Running setup.py (path:/tmp/pip-VbwC6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:24 INFO - Running setup.py (path:/tmp/pip-Y4tN14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:24 INFO - Running setup.py (path:/tmp/pip-U6iGTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:24 INFO - Running setup.py (path:/tmp/pip-Cv5nAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:24 INFO - Running setup.py (path:/tmp/pip-gawiKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:24 INFO - Running setup.py (path:/tmp/pip-rF7X_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:24 INFO - Running setup.py (path:/tmp/pip-vwjd7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:24 INFO - Running setup.py (path:/tmp/pip-LHheMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:24 INFO - Running setup.py (path:/tmp/pip-zdnaMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:24 INFO - Running setup.py (path:/tmp/pip-kfP45R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:24 INFO - Running setup.py (path:/tmp/pip-l1SgN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:24 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:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:24 INFO - Running setup.py (path:/tmp/pip-XXRYlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:25 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:40:25 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:40:25 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:40:25 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:40:25 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:40:25 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:40:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:26 INFO - Downloading blessings-1.6.tar.gz 03:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:27 INFO - Installing collected packages: blessings 03:40:27 INFO - Running setup.py install for blessings 03:40:27 INFO - Successfully installed blessings 03:40:27 INFO - Cleaning up... 03:40:27 INFO - Return code: 0 03:40:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:27 INFO - Reading from file tmpfile_stdout 03:40:27 INFO - Current package versions: 03:40:27 INFO - argparse == 1.2.1 03:40:27 INFO - blessings == 1.6 03:40:27 INFO - blobuploader == 1.2.4 03:40:27 INFO - docopt == 0.6.1 03:40:27 INFO - functools32 == 3.2.3-2 03:40:27 INFO - jsonschema == 2.5.1 03:40:27 INFO - manifestparser == 1.1 03:40:27 INFO - mozInstall == 1.12 03:40:27 INFO - mozcrash == 0.17 03:40:27 INFO - mozdebug == 0.1 03:40:27 INFO - mozdevice == 0.48 03:40:27 INFO - mozfile == 1.2 03:40:27 INFO - mozhttpd == 0.7 03:40:27 INFO - mozinfo == 0.9 03:40:27 INFO - mozleak == 0.1 03:40:27 INFO - mozlog == 3.2 03:40:27 INFO - moznetwork == 0.27 03:40:27 INFO - mozprocess == 0.22 03:40:27 INFO - mozprofile == 0.28 03:40:27 INFO - mozrunner == 6.11 03:40:27 INFO - mozscreenshot == 0.1 03:40:27 INFO - mozsystemmonitor == 0.3 03:40:27 INFO - moztest == 0.7 03:40:27 INFO - mozversion == 1.4 03:40:27 INFO - psutil == 3.1.1 03:40:27 INFO - requests == 1.2.3 03:40:27 INFO - wsgiref == 0.1.2 03:40:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 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 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:27 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:40:27 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:40:27 INFO - Using env: {'DISPLAY': ':0', 03:40:27 INFO - 'HOME': '/home/cltbld', 03:40:27 INFO - 'LANG': 'en_US.UTF-8', 03:40:27 INFO - 'LANGUAGE': 'en_US:en', 03:40:27 INFO - 'LOGNAME': 'cltbld', 03:40:27 INFO - 'MAIL': '/var/mail/cltbld', 03:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:27 INFO - 'MOZ_NO_REMOTE': '1', 03:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:27 INFO - 'NO_EM_RESTART': '1', 03:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:27 INFO - 'PWD': '/builds/slave/test', 03:40:27 INFO - 'SHELL': '/bin/bash', 03:40:27 INFO - 'SHLVL': '1', 03:40:27 INFO - 'TERM': 'linux', 03:40:27 INFO - 'TMOUT': '86400', 03:40:27 INFO - 'USER': 'cltbld', 03:40:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:27 INFO - '_': '/tools/buildbot/bin/python'} 03:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 INFO - Cleaning up... 03:40:27 INFO - Return code: 0 03:40:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:40:27 INFO - Using env: {'DISPLAY': ':0', 03:40:27 INFO - 'HOME': '/home/cltbld', 03:40:27 INFO - 'LANG': 'en_US.UTF-8', 03:40:27 INFO - 'LANGUAGE': 'en_US:en', 03:40:27 INFO - 'LOGNAME': 'cltbld', 03:40:27 INFO - 'MAIL': '/var/mail/cltbld', 03:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:27 INFO - 'MOZ_NO_REMOTE': '1', 03:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:27 INFO - 'NO_EM_RESTART': '1', 03:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:27 INFO - 'PWD': '/builds/slave/test', 03:40:27 INFO - 'SHELL': '/bin/bash', 03:40:27 INFO - 'SHLVL': '1', 03:40:27 INFO - 'TERM': 'linux', 03:40:27 INFO - 'TMOUT': '86400', 03:40:27 INFO - 'USER': 'cltbld', 03:40:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:27 INFO - '_': '/tools/buildbot/bin/python'} 03:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:27 INFO - Cleaning up... 03:40:27 INFO - Return code: 0 03:40:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e1fbdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1369350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', '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:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:40:27 INFO - Using env: {'DISPLAY': ':0', 03:40:27 INFO - 'HOME': '/home/cltbld', 03:40:27 INFO - 'LANG': 'en_US.UTF-8', 03:40:27 INFO - 'LANGUAGE': 'en_US:en', 03:40:27 INFO - 'LOGNAME': 'cltbld', 03:40:27 INFO - 'MAIL': '/var/mail/cltbld', 03:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:27 INFO - 'MOZ_NO_REMOTE': '1', 03:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:27 INFO - 'NO_EM_RESTART': '1', 03:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:27 INFO - 'PWD': '/builds/slave/test', 03:40:27 INFO - 'SHELL': '/bin/bash', 03:40:27 INFO - 'SHLVL': '1', 03:40:27 INFO - 'TERM': 'linux', 03:40:27 INFO - 'TMOUT': '86400', 03:40:27 INFO - 'USER': 'cltbld', 03:40:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:27 INFO - '_': '/tools/buildbot/bin/python'} 03:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:28 INFO - Downloading/unpacking flake8 03:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:40:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:40: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:40: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:40: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:40: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:40: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:40: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:40:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:40:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:40:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:30 INFO - no previously-included directories found matching 'docs/_build' 03:40:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:40:30 INFO - Running setup.py install for pep8 03:40:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:30 INFO - no previously-included directories found matching 'docs/_build' 03:40:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:40:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:40:30 INFO - Cleaning up... 03:40:30 INFO - Return code: 0 03:40:30 INFO - Running post-action listener: _resource_record_post_action 03:40:30 INFO - Running post-action listener: _start_resource_monitoring 03:40:30 INFO - Starting resource monitoring. 03:40:30 INFO - ##### 03:40:30 INFO - ##### Finished create-virtualenv step (success) 03:40:30 INFO - ##### 03:40:30 INFO - ##### 03:40:30 INFO - ##### Running install step. 03:40:30 INFO - ##### 03:40:30 INFO - Running pre-action listener: _resource_record_pre_action 03:40:30 INFO - Running main action method: install 03:40:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:31 INFO - Reading from file tmpfile_stdout 03:40:31 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:31 INFO - Reading from file tmpfile_stdout 03:40:31 INFO - Output received: 03:40:31 INFO - Usage: mozinstall [options] installer 03:40:31 INFO - Options: 03:40:31 INFO - -h, --help show this help message and exit 03:40:31 INFO - -d DEST, --destination=DEST 03:40:31 INFO - Directory to install application into. [default: 03:40:31 INFO - "/builds/slave/test"] 03:40:31 INFO - --app=APP Application being installed. [default: firefox] 03:40:31 INFO - mkdir: /builds/slave/test/build/application 03:40:31 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:40:31 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:40:47 INFO - Reading from file tmpfile_stdout 03:40:47 INFO - Output received: 03:40:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:40:47 INFO - Running post-action listener: _resource_record_post_action 03:40:47 INFO - ##### 03:40:47 INFO - ##### Finished install step (success) 03:40:47 INFO - ##### 03:40:47 INFO - ##### 03:40:47 INFO - ##### Running run-tests step. 03:40:47 INFO - ##### 03:40:47 INFO - Running pre-action listener: _resource_record_pre_action 03:40:47 INFO - Running main action method: run_tests 03:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:47 INFO - Python 2.7.3 03:40:47 INFO - Return code: 0 03:40:47 INFO - grabbing minidump binary from tooltool 03:40:47 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:40:47 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 0x13f81c0>, '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 0x13f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:47 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:40:47 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:40:47 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:40:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:47 INFO - Return code: 0 03:40:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:40:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:40:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:40:48 INFO - Return code: 0 03:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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:40:48 INFO - Using env: {'DISPLAY': ':0', 03:40:48 INFO - 'HOME': '/home/cltbld', 03:40:48 INFO - 'LANG': 'en_US.UTF-8', 03:40:48 INFO - 'LANGUAGE': 'en_US:en', 03:40:48 INFO - 'LOGNAME': 'cltbld', 03:40:48 INFO - 'MAIL': '/var/mail/cltbld', 03:40:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:48 INFO - 'MOZ_NO_REMOTE': '1', 03:40:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:48 INFO - 'NO_EM_RESTART': '1', 03:40:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:48 INFO - 'PWD': '/builds/slave/test', 03:40:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:48 INFO - 'SHELL': '/bin/bash', 03:40:48 INFO - 'SHLVL': '1', 03:40:48 INFO - 'TERM': 'linux', 03:40:48 INFO - 'TMOUT': '86400', 03:40:48 INFO - 'USER': 'cltbld', 03:40:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993', 03:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:48 INFO - '_': '/tools/buildbot/bin/python'} 03:40:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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:40:48 INFO - mozversion application_buildid: 20160613005326 03:40:48 INFO - mozversion application_changeset: 1a585c67e88e31e89aa165f6b706600a2ef92386 03:40:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:48 INFO - mozversion application_name: Firefox 03:40:48 INFO - mozversion application_remotingname: firefox-dev 03:40:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:48 INFO - mozversion application_vendor: Mozilla 03:40:48 INFO - mozversion application_version: 49.0a2 03:40:48 INFO - mozversion platform_buildid: 20160613005326 03:40:48 INFO - mozversion platform_changeset: 1a585c67e88e31e89aa165f6b706600a2ef92386 03:40:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:48 INFO - mozversion platform_version: 49.0a2 03:40:48 INFO - using testdate: 1465814448 03:40:48 INFO - actual date: 1465814448 03:40:48 INFO - starting webserver on 'localhost:51450' 03:40:48 INFO - SUITE-START | Running 2 tests 03:40:48 INFO - TEST-START | dromaeo_css 03:40:48 INFO - operating with platform_type : linux_ 03:40:48 INFO - Initialising browser for dromaeo_css test... 03:40:48 INFO - TEST-INFO | started process 23421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppIob3c/profile http://localhost:51450/getInfo.html) 03:40:52 INFO - PROCESS | 23421 | __metrics Screen width/height:1600/1200 03:40:52 INFO - PROCESS | 23421 | colorDepth:24 03:40:52 INFO - PROCESS | 23421 | Browser inner width/height: 1024/697 03:40:52 INFO - PROCESS | 23421 | __metrics 03:40:53 ERROR - PROCESS | 23421 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:40:53 INFO - PROCESS | 23421 | console.error: PushService: 03:40:53 INFO - PROCESS | 23421 | stateChangeProcessEnqueue: Error transitioning state 03:40:53 INFO - PROCESS | 23421 | UnknownError 03:40:54 INFO - TEST-INFO | 23421: exit 0 03:40:54 INFO - Browser initialized. 03:40:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:54 INFO - TEST-INFO | started process 23513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppIob3c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:05 INFO - PROCESS | 23513 | RSS: Main: 145326080 03:41:05 INFO - PROCESS | 23513 | 03:41:57 INFO - PROCESS | 23513 | 1465814517135 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:44:05 INFO - PROCESS | 23513 | Cycle 1(1): loaded http://localhost:51450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51450/tests/dromaeo/cssquery-ext.html) 03:44:06 INFO - PROCESS | 23513 | RSS: Main: 252366848 03:44:06 INFO - PROCESS | 23513 | 03:47:08 INFO - PROCESS | 23513 | Cycle 1(1): loaded http://localhost:51450/tests/dromaeo/cssquery-ext.html (next: http://localhost:51450/tests/dromaeo/cssquery-jquery.html) 03:47:09 INFO - PROCESS | 23513 | RSS: Main: 226676736 03:47:09 INFO - PROCESS | 23513 | 03:50:11 INFO - PROCESS | 23513 | Cycle 1(1): loaded http://localhost:51450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51450/tests/dromaeo/cssquery-mootools.html) 03:50:11 INFO - PROCESS | 23513 | RSS: Main: 220635136 03:50:11 INFO - PROCESS | 23513 | 03:53:13 INFO - PROCESS | 23513 | Cycle 1(1): loaded http://localhost:51450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51450/tests/dromaeo/cssquery-prototype.html) 03:53:14 INFO - PROCESS | 23513 | RSS: Main: 228466688 03:53:14 INFO - PROCESS | 23513 | 03:56:17 INFO - PROCESS | 23513 | Cycle 1(1): loaded http://localhost:51450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51450/tests/dromaeo/cssquery-yui.html) 03:56:17 INFO - PROCESS | 23513 | RSS: Main: 211222528 03:56:17 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | Cycle 1(1): loaded http://localhost:51450/tests/dromaeo/cssquery-yui.html (next: http://localhost:51450/tests/dromaeo/cssquery-dojo.html) 03:59:20 INFO - PROCESS | 23513 | RSS: Main: 262148096 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | __start_tp_report 03:59:20 INFO - PROCESS | 23513 | _x_x_mozilla_page_load 03:59:20 INFO - PROCESS | 23513 | _x_x_mozilla_page_load_details 03:59:20 INFO - PROCESS | 23513 | |i|pagename|runs| 03:59:20 INFO - PROCESS | 23513 | |0;dojo.html;3284.5894263217097;3325.7838240514366;3330.38387898239;3342.5487559179533;3369.3092915952216;5369.301990741203;5464.890702185954;5471.179323101537;5493.533049690781;5497.120460726284;5315.335583052119;5372.865678358034;5378.569714422846;5386.838394848151;5409.107497262957;4826.855194344175;4832.87917802056;4882.731449770261;4886.731229782361;4987.551120399164;4819;4961.305417241589;5007.549320561149;5010.498950104997;5010.574101201402;4911.8772030699165;4935.728534930578;4959.206526955688;4974.751262436882;4992.051510213066;5039.72281524516;5045.041442125985;5057.216131499624;5057.468965758598;5062;4816.951830481686;4835.153848076572;4911.361523002022;4946.703197808107;4987.326710894019;5239.397469291042;5251.291075704769;5261.026710058613;5269.973650131763;5294.49702278283;5789.160571717078;5797.072468405035;5807.622504537234;5820.82537523875;5825.271841019872;5670.716464176775;5706;5735.512481439083;5811.128330750379;5820.505257053155;5410.08028635133;5443.59173062018;5465.344158700942;5467.343918729698;5469.507744303032;5799.5070419014855;5922.378150294243;5925.40745925404;5930.377310382348;5936.9406305937255;5615.550755939515;5680.744366503517;5689.886202275931;5748.885022299614;5770.682612456271;5814.389489103668;5817.127430885401;5818.883622327615;5848.736806843703;5854.502367298742;5622.91565626516;5670.971645141748;5781.739821708034;5786.07422812348;5791.88416231673;5714.05718056516;5743.511801496836;5759.884802304015;5762.711864406763;5787.305523337142;4423.469183697976;4445.488768791631;4446.888827779331;4447.644188464915;4470.642348612103;3960.6039396060164;3969.7816620085596;3972.3842804365368;3989.5412027616617;4031.314676505001;5534.335879694462;5559.11054231321;5559.27729395176;5562.554995600342;5570.387257401682;5830.737616807254;5844.620099693507;5847.853803654858;5855.707214639251;5878.353381128072;5369.624126311121;5424.484673955968;5433.592480563973;5484.396716361277;5516.062269414209;5015.14742493777;5026.597872170218;5028.748562571856;5032.723200224023;5037.345145131183;5929.288485381696;5992.191054207713;6031.788887388921;6033.276006879202;6037.840984283444;5711.057675483498;5792.768289268551;5796.739146738322;5858.384869588632;5869.119632055226;6106.023036314168;6120.693965301628;6123.7244324006415;6125.081237814364;6128.662923539248;5820.097884827858;5830.737616807169;5832.0085585451425;5832.883342333044;5835.591508594358;5677.8864422710485;5823.4467725566;5858.531317494505;5882.294124705063;5919.556033297434;5746.770129194785;5754.772408161686;5770.653760774367;5782.595218334676;5798.043322851851;5538.418466061005;5753.993051215937;5757.280339957505;5761.654300741969;5769.249997500298;5526.889462210653;5582.665040097607;5588.804391846266;5639.182318563868;5646.153077038477;5717.599768016199;5751.9424805751405;5762.394948530512;5767.221425107557;5770.163326317745;5468.56251499887;5512.924979628934;5553.278073850373;5636;5653.802116925888 03:59:20 INFO - PROCESS | 23513 | |1;ext.html;605.3613437823097;657.5035847934812;662.678600878574;669.2571245917035;673.7473447457204;33219.16952076199;45801.54198458019;45943.5405645943;46040.309395359014;46064.76967615157;49419.75290123553;50022.24966625503;50099.24851127236;50146.24780628293;50192.49807501924;8241.95879020607;8875.467471951672;9113.544322783868;9114.13415725505;10720.410377429238;10648.62729804457;10793.460326983659;10797.514111864946;10799.190060745435;10802.351858888453;10863.891361086407;10871.184661150406;10902.182336324768;10954.671359859178;10972.286801357886;8407.033191183;10803.945980270088;10806.081483073947;11049.116070714404;11086.944565277203;10573.154147668169;10992.615258465916;10993.670189894236;10994.780104397947;11000.284981476178;46278;46657;46883.765581172214;46960.530394696296;47080.7645961768;3706.258748250361;3760.9469348582443;3781.8676346327748;3792.127810603549;3818.4081467372603;35511.4673279901;35852.282954341026;35873.82063089694;36031.4595281071;36165.819170903975;4373.846915357947;4698.769464451455;4776.027766912421;4788.715522146706;4842.515748425165;382717;384444.0777796121;384831;386748;388750;40812.18375632471;71733.64133179301;72258;72514.2748572518;72583;42136;42192.36711449331;42392.788036059625;42419.15161696749;42474.57525424768;17748.822511774717;18148;18160.273589056553;18184.818151818312;18191.181396837175;13459;14901.254937253094;15107.39570417193;15129;15554;9294.748467116058;9396.389234699722;9431.245500359955;9489.051094890594;9527.333086683866;3604.5494313210847;3615.6926661233565;3629.1290090378648;3655.6344365563764;3697.5932647408763;1098;1110.8444817725524;1125.5835340923911;1128.0073535288893;1169.830374595679;34683.13292167716;34816.82591587026;35119.824400877835;35168.29663406718;35173.824130879184;1170.4440390814295;1197.6886009637558;1210.6973256685828;1224.406163010939;1296.2416986063258;17981.190846411944;18152.273909043754;18161.909190453964;18165.36421225277;18213.63572728538;655403;660264;660662;663144;665411;63193.684031580466;64703.67648161729;64974;65077;65138.34861651417;1328.5018118205674;1467.4643755029338;1468.4199741102204;1479.5191562741936;1486.472302332678;33947.4907876387;34812.82593587117;35207.82396088003;35811.10472238215;36113.63886361103;54516.727416362664;55044.724776375864;55061.174082387995;55112;55166.44833551613;350234;356312;356419;357854;358357;27931.72068279291;29738.70261297446;30180;30986.380272394876;31627.367452650356;52074.73962630163;52687;53285.46714532805;53831.73084134554;54284;43396.56603434052;43515.34566805419;44379.55620443754;44615.55384446114;45078;43021.569784301755;43623;43991;44828.55171448244;45210;43894.56105438905;44510.55489445194;45107;45514;45870;38018.429723553614;38208.80895595504;38740.6125938737;38863.80568097141;39047.6095239044;29179.85410073021;29736.702632973393;29781.5532767013;29974.023905968843;30095 03:59:20 INFO - PROCESS | 23513 | |2;jquery.html;429.6252933209638;432.75765571280067;435.30134134713774;440.32410250265866;442.36741459712607;18318.084095795206;19737.210511579557;19812.10845511952;19903.303384381514;20110.89944550277;17457.21442535086;17679.381221657244;18189.90816056154;18348.08259587022;18410;5656.349519805213;5871.3541510433815;5878.764849406019;5880.411958804107;5881.264841894763;4322.913541729164;5313.442088580682;5668.433156684319;5746.48281654651;6430.48556115512;6419.582727122722;6511.967440162793;6529.902051469232;6540.313267106957;6577.046328282396;6372.267189273247;6377.904331435032;6483.805485835433;6497.5126865485045;6537.509686773511;3829;5355.30381050461;5700.942990570083;5802.419758024206;5806.187133801229;20565;23871.522569548684;23944.760552394426;24017;24224;3072.2626569623353;3148.66938971407;3209.1014515935576;3253.9349213015607;3342.398368293706;14165.785957845677;14827.406903723839;15097.3206205721;15245.542633720896;15580.454684086002;2015.506200980769;2044.7852975437513;2057.6913462980524;2096.9895150524303;2133.6799480077957;80084.19915800825;82414;82934.58532707358;83100.58449707773;85033.14966850315;10976.780464390667;11098.2786118902;11326.546938122548;11513.827292590619;11562.537498500134;15926.124063176405;15980.680386392207;16060.839391605934;16062.839371606367;16105.355785768672;8610.65557377698;8768.939299264668;8845.159709827556;8859.557022148867;8908.198262156437;8480.872786908201;8504.574771261412;8583.484990900566;8671.869921951176;8699.347548933856;6984.580925144508;7015.964920175366;7055.823604409931;7153.535020223669;7165.247648996885;1909.417627623588;1935.400025991947;1938.893360865166;1978.1493957598084;1988.9502762430766;916.2166347772692;975.9219262458986;1014.8376259798397;1085.2240647936605;1088.4394536813547;19095.14071866769;19261.903690481457;19621.31325403604;20067;20440.897795510926;1015.3907655406697;1031.376017509411;1052.2266134391216;1144.6508814811561;1160.7040204747905;11125.666230013112;11739.295642261492;11762.470688819023;11765.764684706259;11770.646880593597;535912;543862;548663;564368;565216;85242;85643.57178214069;86214.56892715622;88292;90933.09066909378;1051.558345494894;1064.387976913278;1079.3847506921136;1084.143526613982;1086.7120213143523;17680;18026.1888215028;18172.545686357946;18262.72605910939;18407.63184736271;36512;38765.6123438762;39180.41229381619;40741.38887916743;42155.103020363546;55311.723441382535;55432.44567554273;55591.722041389534;55825.72087139538;56112.71943640419;9118.544072796201;9179.678711245075;9181.449113053239;9248.21390181842;9382.577783999874;13644.65888352799;13702.38339274755;13777.724445511234;13800.240986745825;13879.375428105961;11922.642320730392;12085.335306558223;12200.47274708027;12386.938065309616;12725.109242352946;11671.88328116708;11942.641720748392;11958.04335653163;12174.817377739164;12434.191777534432;12221.75556488883;12366.62900112998;12432.502699891904;12522.874771252535;12535;7558.811029724301;7943.285104340637;9222.123898229658;9281.72154835356;9365.344425890122;12534.310612916377;12635.557755478514;12649.873501265238;12666.683332916382;12693.111482196158 03:59:20 INFO - PROCESS | 23513 | |3;mootools.html;1406.6975600245958;1559.1502631066069;1574.669319442917;1799.7120460726287;1906.9332573359927;8907.68823091192;9261.351705380626;9292.303077269198;9548.140667339938;9552.904470955289;9266.768330791716;9436.292278079138;9443.57503912324;9446.433214007164;9455.621775128986;2193.451637090727;2445.4864478459544;2485.515324511721;2488.5147396257694;2546.9235922922344;2465.593177125772;2474.653548503211;2482.0816297969777;2486.664300319461;2487.2040946897;2448.791852692523;2452.4849781545895;2452.6443665668558;2455.594826853576;2478.3184624228393;2169.403414061138;2400.627902675088;2483.875806209682;2493.0651005872796;2509.498100379913;2385.332107010023;2393.8563686178886;2395.3053614451787;2397.988010059956;2426.211481268595;9485.857712134324;9561.569729362196;9562;9563.139317461393;9572.904270957271;5421.674699518042;5572.192032155355;5582.051051321285;5583.497485226349;5595.692236926968;3477.913052173716;3603.0992251937014;3624.963750362489;3635.709143268532;3662.10278481771;1220.9511619535208;1244.6577191272472;1253.5173958026135;1254.6486983644595;1267.5310135249924;12776.744465110645;13143.539976100887;13288.402021909038;13663.18020918748;13713.862861371457;4651.2557990722;4717.410323709536;4747.192977193886;4762.59517940972;4812.494688057704;10027.598896044077;10034.64878729241;10064.899351006543;10089;10095.444750538643;4954.281629163823;5455.454454554592;5460.890782184413;5461.563074953994;5464.890702185934;5152.252923326097;5324.547413469821;5334.279872217278;5387.568994480433;5395.757190926339;3788.0719223790347;3856.0745421099296;3884.514435695538;3906.316394630985;3935.173613541131;1169.1757311095657;1172.3376292394769;1181.8227265910182;1182.131133616791;1204.0367705835472;954.5847556313026;968.9418634881789;980.6175591519313;990.5839547390113;994.472929347447;5953.166556682068;5999.910001349983;6126;6547.869042619121;6566.704498297588;1013.280570794744;1068.5992752717732;1094.5949998500605;1112.6495154026456;1149.3850789827402;4258.1483703258855;4351.06452112791;4368;4413.911721765547;4513.119941611354;11103;11962.162648614514;12265.141440099285;12282.508699651913;12285.508579656713;11550.826737598944;11709.648710538697;11892.286462812259;11989;12021.038316934624;8790.86813697795;8871.600777965006;8916.108389161032;8927.508987005647;8971.05803890595;6257.937420625917;6312.905306420499;6335.334789847;6411.070394792636;6527.05357723118;10702.625408110678;10851.45742712877;10897.509612067635;11037.834432483358;11186.496607652838;10872.238943273895;11304.039156671775;11417.771644567229;11418.771624567627;11433;8348.791280218044;8587.355948303777;8597.914020859711;8600.569971501274;8763.3427492937;8812.60343284541;9040.819183616422;9337.439753614804;9350.438973661601;9520.666776662783;8192.467489613156;8280.958595206985;8292.37807164453;8386.874196886929;8545.017323007934;8166.754997350089;8262.049864265686;8392.496450213006;8467.49195048299;8496.915030849612;7532.472726909064;7592.8481430372185;7620.314171724572;7624.885626715492;7635.045619297588;5493.038718224375;5510.448955104457;5574.275344205227;5649.68926709035;5726.79956201531;5538.307711536058;5553.694546799965;5572.777088916398;5580.609357344947;5639.943600563942 03:59:20 INFO - PROCESS | 23513 | |4;prototype.html;357.2355159957691;358.2762819105409;358.45156909927806;359.18106716685963;361.2666287436503;5518.475744804242;5567.944320556799;5579.944200557993;5607.4112218217115;5624.7906700059475;5456.781728730846;5491.697956612385;5497.39528651848;5497.780088796453;5530.557555395569;3995.2009598080353;4079.3473044312914;4356.782160891943;4381.255186618282;4391.5827996340295;4315.352697095445;4335.241332766753;4355.738655680653;4370.978145109286;4376.912461750763;4131.938020929689;4301.935470967938;4331.198728235271;4340.218760623086;4344.695871289011;4152.425241875532;4375.14684636496;4377.496587892401;4381.824727010916;4390.473143222818;3878.3212937735784;3882.2429626222897;3890.2688303704863;3893.1240470894104;3901.551321598024;5114.514121158484;5268.81559145428;5282;5300;5305.3818585331455;4947.876303092416;4947.9505204947845;4954.083494553519;4958.479359667219;4958.553730164303;5625.6905870177125;5652.886942261173;5667.603267771257;5708.20085188074;5754.395788442237;4096.201240758053;4251.829926802924;4272.893177670583;4290.678199135046;4292.377605247253;5910.320313163998;5910.468057874769;5927.599322274443;5929.911051334234;5957.8808423831715;4304.203722311382;4321.157374311979;4326.091520780671;4359.346098085249;4376.431063961728;4301.333293339538;4427.358033085185;4427.959429534057;4452.376667266585;4487.326900964816;4941.2835138905375;4966.1061009018;4975.5522003019905;4976.527229913225;4976.950230497721;5727.0836666134055;5746.454086861741;5753.784792854781;5769.971150144306;5794.739236734273;1500.5948393933577;1527.5111964171358;1540.7688846673088;1542.0978727444347;1548.9699349932168;972.8978457262027;975.8975307592742;984.4831463481729;990.7424069741775;1050.8755631474403;5533.861653458695;5581.246531718247;5590.832275031756;5593.580481463907;5618.297712785902;5864.533866533367;5875.441833025856;5875.941240587625;5905.080848724182;5906.527477801766;5457.690154363004;5562.888742225133;5570.498655121059;5588.6646801192055;5617.662940223599;3117.2830249042845;3121.282105115836;3129.2959084206327;3149.10250578584;3155.2269693925136;5797.130430435468;6042.728077236535;6050.334463209044;6058.666773327421;6092.527259462153;5984.31180414258;6003.3996600339615;6014.8195554133445;6020.789272375446;6033.095035744585;6038.879222415615;6078.908816367758;6080.908786368208;6092.45167934888;6099.359567245376;5765.538756899522;5863.560232982629;5933.884710527008;5964.761409543743;5974.492168165754;5781.797637082682;5789.9710501447225;5790.392008839011;5807.564432667651;5820.534357251325;5891;5995.370486098896;6053.485453736482;6059.303180134341;6061.545384096298;4228.725132866354;4275.251830929637;4284.078923031563;4286.549912259168;4321.114171594879;5783.855403614775;5854.180414742024;5908.291005079418;5917.846020026226;5935;5499.257600223918;5678.438429431939;5696.259486266758;5731.054376027909;5759.481646651821;5673.77304907799;5680.318361796611;5684.63049901755;5694.174344720075;5704.771809127588;5260.868478288074;5420.593455490775;5609.158626206102;5663.008973429715;5666.46168613981;5723.6851973141875;5799.362070172193;5801.94198058014;5817.854553636193;5837.94162058391;5651.88696226065;5679.488846003879;5690.317161940594;5701.116326969326;5719.428057194247 03:59:20 INFO - PROCESS | 23513 | |5;yui.html;807.6971135824062;825.1954344514098;837.5728378526951;841.9031811341694;895.8745775591415;15838.76241856373;16140.757888631666;16349.346026158953;17531.38640147595;17611.29554817809;15953.601159971007;15958.441454549093;16043.278052487636;16111.597210069755;16119.516414507583;742.9182789893107;863.6415887406719;875.2735229759301;882.3206131278912;887.6582515731458;874.4403581707712;876.0844917061654;879.0155026370473;881.1276835932413;882.0694167653123;915.6886658536097;918.5682729117304;920.4339331311262;920.6961702638114;920.7836158502746;760.3726925286661;899.1458114790942;919.1268295119596;919.9862002069974;921.5622579274791;677.109600874848;677.7492327838731;677.7526202935942;677.8034370032734;677.989830152548;15930.362785488567;15983.760243596354;16009.199540023068;16014.599635009217;16020.439284624983;15488.380464781396;15537.611559711098;15574.610634734108;15829.050256984618;15865.286062127232;13176.934115329457;13700.65748356289;13769.31153442324;13864.792028119486;13921.164730116225;4751.3348131261655;4752.405949256343;4755.310479980418;4800.591949684281;4936.136176169156;73074.26925730781;74304.62847685836;74949;75277;75373;12129.514819407124;12158.756824863452;12312.938435307766;12314.13801033919;12417.565385211474;21432.678509822366;21605.135794568356;21645.35063948084;21751.45621359447;22693.205737799097;8928.642854285756;8999.19007289347;8999.685011024583;9142.131497507726;9207;4981.701097934063;4993.550580447777;5014.147594908874;5047.159301893798;5098.5411312982005;3738.27103714773;3881.165549406891;3885.339492286318;3889.416587511839;3893.0267433141717;665.1489656537643;669.8794217040881;671.2817285504464;679.296927679849;681.877262092828;660.4386271669139;685.1127789512593;691.7302252121676;719.521518190408;731.7841236835146;9350.90649093514;9659.90340096604;9700.466474343979;9751.561179746928;9833.901660983442;640.2157357237347;707.3563057617544;720.1933834105835;724.1816747075876;729.759179470784;4503.617192538605;4528.682992190515;4654.534546545318;4682.672212945061;4729.43246810385;118769;119463;119552.40223799;119592;120050.3997480007;99938;101332.49333753284;101517.49241253747;102226;103842.48078759709;69489;91489.54255228682;92133.07866921379;93779.53110234404;94662;8670.56918669822;8835;8896;8948.149925757043;9050.637974480947;53959.46040539701;54387.18419223794;54641.453585463634;56606.018789342175;56698.14952775629;72447.63776181085;80507.59746201232;82127.58936205281;82987;83427;11311.830322545333;11641.883581164419;11868.76262474763;12347;12632.332329346962;13403.195808251536;13634.727305454035;13754.449822007007;13858.514951976633;14196.077254978394;10705.625303114353;10963.671089867317;13146.145500542434;13218.735625287633;13412.463501459832;13434.596962091153;13595.592132236048;13908.37412316428;13987.510437134652;13987.720245595234;13259;13791.10357826738;13798;13816.309184540532;13852.722945541234;12003.81994270104;12160.391980400767;12539.24764514132;12629.621111366674;12694.873051269738;12165.391730413266;12737;12826.294553799631;12934.741305173655;13070.215787052808 03:59:20 INFO - PROCESS | 23513 | __end_tp_report 03:59:20 INFO - PROCESS | 23513 | __start_cc_report 03:59:20 INFO - PROCESS | 23513 | _x_x_mozilla_cycle_collect,880 03:59:20 INFO - PROCESS | 23513 | __end_cc_report 03:59:20 INFO - PROCESS | 23513 | __startTimestamp1465815560313__endTimestamp 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | ------- Summary: start ------- 03:59:20 INFO - PROCESS | 23513 | Number of tests: 6 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | [#0] dojo.html Cycles:165 Average:5406.49 Median:5615.55 stddev:594.26 (10.6%) stddev-sans-first:572.29 03:59:20 INFO - PROCESS | 23513 | Values: 3284.6 3325.8 3330.4 3342.5 3369.3 5369.3 5464.9 5471.2 5493.5 5497.1 5315.3 5372.9 5378.6 5386.8 5409.1 4826.9 4832.9 4882.7 4886.7 4987.6 4819.0 4961.3 5007.5 5010.5 5010.6 4911.9 4935.7 4959.2 4974.8 4992.1 5039.7 5045.0 5057.2 5057.5 5062.0 4817.0 4835.2 4911.4 4946.7 4987.3 5239.4 5251.3 5261.0 5270.0 5294.5 5789.2 5797.1 5807.6 5820.8 5825.3 5670.7 5706.0 5735.5 5811.1 5820.5 5410.1 5443.6 5465.3 5467.3 5469.5 5799.5 5922.4 5925.4 5930.4 5936.9 5615.6 5680.7 5689.9 5748.9 5770.7 5814.4 5817.1 5818.9 5848.7 5854.5 5622.9 5671.0 5781.7 5786.1 5791.9 5714.1 5743.5 5759.9 5762.7 5787.3 4423.5 4445.5 4446.9 4447.6 4470.6 3960.6 3969.8 3972.4 3989.5 4031.3 5534.3 5559.1 5559.3 5562.6 5570.4 5830.7 5844.6 5847.9 5855.7 5878.4 5369.6 5424.5 5433.6 5484.4 5516.1 5015.1 5026.6 5028.7 5032.7 5037.3 5929.3 5992.2 6031.8 6033.3 6037.8 5711.1 5792.8 5796.7 5858.4 5869.1 6106.0 6120.7 6123.7 6125.1 6128.7 5820.1 5830.7 5832.0 5832.9 5835.6 5677.9 5823.4 5858.5 5882.3 5919.6 5746.8 5754.8 5770.7 5782.6 5798.0 5538.4 5754.0 5757.3 5761.7 5769.2 5526.9 5582.7 5588.8 5639.2 5646.2 5717.6 5751.9 5762.4 5767.2 5770.2 5468.6 5512.9 5553.3 5636.0 5653.8 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | [#1] ext.html Cycles:180 Average:63629.61 Median:20918.42 stddev:129873.91 (620.9%) stddev-sans-first:130152.03 03:59:20 INFO - PROCESS | 23513 | Values: 605.4 657.5 662.7 669.3 673.7 33219.2 45801.5 45943.5 46040.3 46064.8 49419.8 50022.2 50099.2 50146.2 50192.5 8242.0 8875.5 9113.5 9114.1 10720.4 10648.6 10793.5 10797.5 10799.2 10802.4 10863.9 10871.2 10902.2 10954.7 10972.3 8407.0 10803.9 10806.1 11049.1 11086.9 10573.2 10992.6 10993.7 10994.8 11000.3 46278.0 46657.0 46883.8 46960.5 47080.8 3706.3 3760.9 3781.9 3792.1 3818.4 35511.5 35852.3 35873.8 36031.5 36165.8 4373.8 4698.8 4776.0 4788.7 4842.5 382717.0 384444.1 384831.0 386748.0 388750.0 40812.2 71733.6 72258.0 72514.3 72583.0 42136.0 42192.4 42392.8 42419.2 42474.6 17748.8 18148.0 18160.3 18184.8 18191.2 13459.0 14901.3 15107.4 15129.0 15554.0 9294.7 9396.4 9431.2 9489.1 9527.3 3604.5 3615.7 3629.1 3655.6 3697.6 1098.0 1110.8 1125.6 1128.0 1169.8 34683.1 34816.8 35119.8 35168.3 35173.8 1170.4 1197.7 1210.7 1224.4 1296.2 17981.2 18152.3 18161.9 18165.4 18213.6 655403.0 660264.0 660662.0 663144.0 665411.0 63193.7 64703.7 64974.0 65077.0 65138.3 1328.5 1467.5 1468.4 1479.5 1486.5 33947.5 34812.8 35207.8 35811.1 36113.6 54516.7 55044.7 55061.2 55112.0 55166.4 350234.0 356312.0 356419.0 357854.0 358357.0 27931.7 29738.7 30180.0 30986.4 31627.4 52074.7 52687.0 53285.5 53831.7 54284.0 43396.6 43515.3 44379.6 44615.6 45078.0 43021.6 43623.0 43991.0 44828.6 45210.0 43894.6 44510.6 45107.0 45514.0 45870.0 38018.4 38208.8 38740.6 38863.8 39047.6 29179.9 29736.7 29781.6 29974.0 30095.0 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | [#2] jquery.html Cycles:180 Average:30979.79 Median:23980.88 stddev:90474.71 (377.3%) stddev-sans-first:90699.43 03:59:20 INFO - PROCESS | 23513 | Values: 429.6 432.8 435.3 440.3 442.4 18318.1 19737.2 19812.1 19903.3 20110.9 17457.2 17679.4 18189.9 18348.1 18410.0 5656.3 5871.4 5878.8 5880.4 5881.3 4322.9 5313.4 5668.4 5746.5 6430.5 6419.6 6512.0 6529.9 6540.3 6577.0 6372.3 6377.9 6483.8 6497.5 6537.5 3829.0 5355.3 5700.9 5802.4 5806.2 20565.0 23871.5 23944.8 24017.0 24224.0 3072.3 3148.7 3209.1 3253.9 3342.4 14165.8 14827.4 15097.3 15245.5 15580.5 2015.5 2044.8 2057.7 2097.0 2133.7 80084.2 82414.0 82934.6 83100.6 85033.1 10976.8 11098.3 11326.5 11513.8 11562.5 15926.1 15980.7 16060.8 16062.8 16105.4 8610.7 8768.9 8845.2 8859.6 8908.2 8480.9 8504.6 8583.5 8671.9 8699.3 6984.6 7016.0 7055.8 7153.5 7165.2 1909.4 1935.4 1938.9 1978.1 1989.0 916.2 975.9 1014.8 1085.2 1088.4 19095.1 19261.9 19621.3 20067.0 20440.9 1015.4 1031.4 1052.2 1144.7 1160.7 11125.7 11739.3 11762.5 11765.8 11770.6 535912.0 543862.0 548663.0 564368.0 565216.0 85242.0 85643.6 86214.6 88292.0 90933.1 1051.6 1064.4 1079.4 1084.1 1086.7 17680.0 18026.2 18172.5 18262.7 18407.6 36512.0 38765.6 39180.4 40741.4 42155.1 55311.7 55432.4 55591.7 55825.7 56112.7 9118.5 9179.7 9181.4 9248.2 9382.6 13644.7 13702.4 13777.7 13800.2 13879.4 11922.6 12085.3 12200.5 12386.9 12725.1 11671.9 11942.6 11958.0 12174.8 12434.2 12221.8 12366.6 12432.5 12522.9 12535.0 7558.8 7943.3 9222.1 9281.7 9365.3 12534.3 12635.6 12649.9 12666.7 12693.1 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | [#3] mootools.html Cycles:180 Average:6211.00 Median:4684.33 stddev:3581.54 (76.5%) stddev-sans-first:3573.39 03:59:20 INFO - PROCESS | 23513 | Values: 1406.7 1559.2 1574.7 1799.7 1906.9 8907.7 9261.4 9292.3 9548.1 9552.9 9266.8 9436.3 9443.6 9446.4 9455.6 2193.5 2445.5 2485.5 2488.5 2546.9 2465.6 2474.7 2482.1 2486.7 2487.2 2448.8 2452.5 2452.6 2455.6 2478.3 2169.4 2400.6 2483.9 2493.1 2509.5 2385.3 2393.9 2395.3 2398.0 2426.2 9485.9 9561.6 9562.0 9563.1 9572.9 5421.7 5572.2 5582.1 5583.5 5595.7 3477.9 3603.1 3625.0 3635.7 3662.1 1221.0 1244.7 1253.5 1254.6 1267.5 12776.7 13143.5 13288.4 13663.2 13713.9 4651.3 4717.4 4747.2 4762.6 4812.5 10027.6 10034.6 10064.9 10089.0 10095.4 4954.3 5455.5 5460.9 5461.6 5464.9 5152.3 5324.5 5334.3 5387.6 5395.8 3788.1 3856.1 3884.5 3906.3 3935.2 1169.2 1172.3 1181.8 1182.1 1204.0 954.6 968.9 980.6 990.6 994.5 5953.2 5999.9 6126.0 6547.9 6566.7 1013.3 1068.6 1094.6 1112.6 1149.4 4258.1 4351.1 4368.0 4413.9 4513.1 11103.0 11962.2 12265.1 12282.5 12285.5 11550.8 11709.6 11892.3 11989.0 12021.0 8790.9 8871.6 8916.1 8927.5 8971.1 6257.9 6312.9 6335.3 6411.1 6527.1 10702.6 10851.5 10897.5 11037.8 11186.5 10872.2 11304.0 11417.8 11418.8 11433.0 8348.8 8587.4 8597.9 8600.6 8763.3 8812.6 9040.8 9337.4 9350.4 9520.7 8192.5 8281.0 8292.4 8386.9 8545.0 8166.8 8262.0 8392.5 8467.5 8496.9 7532.5 7592.8 7620.3 7624.9 7635.0 5493.0 5510.4 5574.3 5649.7 5726.8 5538.3 5553.7 5572.8 5580.6 5639.9 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | [#4] prototype.html Cycles:180 Average:4864.05 Median:5580.60 stddev:1401.77 (25.1%) stddev-sans-first:1364.28 03:59:20 INFO - PROCESS | 23513 | Values: 357.2 358.3 358.5 359.2 361.3 5518.5 5567.9 5579.9 5607.4 5624.8 5456.8 5491.7 5497.4 5497.8 5530.6 3995.2 4079.3 4356.8 4381.3 4391.6 4315.4 4335.2 4355.7 4371.0 4376.9 4131.9 4301.9 4331.2 4340.2 4344.7 4152.4 4375.1 4377.5 4381.8 4390.5 3878.3 3882.2 3890.3 3893.1 3901.6 5114.5 5268.8 5282.0 5300.0 5305.4 4947.9 4948.0 4954.1 4958.5 4958.6 5625.7 5652.9 5667.6 5708.2 5754.4 4096.2 4251.8 4272.9 4290.7 4292.4 5910.3 5910.5 5927.6 5929.9 5957.9 4304.2 4321.2 4326.1 4359.3 4376.4 4301.3 4427.4 4428.0 4452.4 4487.3 4941.3 4966.1 4975.6 4976.5 4977.0 5727.1 5746.5 5753.8 5770.0 5794.7 1500.6 1527.5 1540.8 1542.1 1549.0 972.9 975.9 984.5 990.7 1050.9 5533.9 5581.2 5590.8 5593.6 5618.3 5864.5 5875.4 5875.9 5905.1 5906.5 5457.7 5562.9 5570.5 5588.7 5617.7 3117.3 3121.3 3129.3 3149.1 3155.2 5797.1 6042.7 6050.3 6058.7 6092.5 5984.3 6003.4 6014.8 6020.8 6033.1 6038.9 6078.9 6080.9 6092.5 6099.4 5765.5 5863.6 5933.9 5964.8 5974.5 5781.8 5790.0 5790.4 5807.6 5820.5 5891.0 5995.4 6053.5 6059.3 6061.5 4228.7 4275.3 4284.1 4286.5 4321.1 5783.9 5854.2 5908.3 5917.8 5935.0 5499.3 5678.4 5696.3 5731.1 5759.5 5673.8 5680.3 5684.6 5694.2 5704.8 5260.9 5420.6 5609.2 5663.0 5666.5 5723.7 5799.4 5801.9 5817.9 5837.9 5651.9 5679.5 5690.3 5701.1 5719.4 03:59:20 INFO - PROCESS | 23513 | 03:59:20 INFO - PROCESS | 23513 | [#5] yui.html Cycles:180 Average:21543.46 Median:4753.86 stddev:30942.72 (650.9%) stddev-sans-first:30990.35 03:59:20 INFO - PROCESS | 23513 | Values: 807.7 825.2 837.6 841.9 895.9 15838.8 16140.8 16349.3 17531.4 17611.3 15953.6 15958.4 16043.3 16111.6 16119.5 742.9 863.6 875.3 882.3 887.7 874.4 876.1 879.0 881.1 882.1 915.7 918.6 920.4 920.7 920.8 760.4 899.1 919.1 920.0 921.6 677.1 677.7 677.8 677.8 678.0 15930.4 15983.8 16009.2 16014.6 16020.4 15488.4 15537.6 15574.6 15829.1 15865.3 13176.9 13700.7 13769.3 13864.8 13921.2 4751.3 4752.4 4755.3 4800.6 4936.1 73074.3 74304.6 74949.0 75277.0 75373.0 12129.5 12158.8 12312.9 12314.1 12417.6 21432.7 21605.1 21645.4 21751.5 22693.2 8928.6 8999.2 8999.7 9142.1 9207.0 4981.7 4993.6 5014.1 5047.2 5098.5 3738.3 3881.2 3885.3 3889.4 3893.0 665.1 669.9 671.3 679.3 681.9 660.4 685.1 691.7 719.5 731.8 9350.9 9659.9 9700.5 9751.6 9833.9 640.2 707.4 720.2 724.2 729.8 4503.6 4528.7 4654.5 4682.7 4729.4 118769.0 119463.0 119552.4 119592.0 120050.4 99938.0 101332.5 101517.5 102226.0 103842.5 69489.0 91489.5 92133.1 93779.5 94662.0 8670.6 8835.0 8896.0 8948.1 9050.6 53959.5 54387.2 54641.5 56606.0 56698.1 72447.6 80507.6 82127.6 82987.0 83427.0 11311.8 11641.9 11868.8 12347.0 12632.3 13403.2 13634.7 13754.4 13858.5 14196.1 10705.6 10963.7 13146.1 13218.7 13412.5 13434.6 13595.6 13908.4 13987.5 13987.7 13259.0 13791.1 13798.0 13816.3 13852.7 12003.8 12160.4 12539.2 12629.6 12694.9 12165.4 12737.0 12826.3 12934.7 13070.2 03:59:20 INFO - PROCESS | 23513 | -------- Summary: end -------- 03:59:20 INFO - PROCESS | 23513 | 03:59:21 INFO - TEST-INFO | 23513: exit 0 03:59:21 INFO - TEST-OK | dromaeo_css | took 1112792ms 03:59:21 INFO - TEST-START | kraken 03:59:21 INFO - operating with platform_type : linux_ 03:59:21 INFO - Initialising browser for kraken test... 03:59:21 INFO - TEST-INFO | started process 23702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubGc8h/profile http://localhost:51450/getInfo.html) 03:59:24 INFO - PROCESS | 23702 | __metrics Screen width/height:1600/1200 03:59:24 INFO - PROCESS | 23702 | colorDepth:24 03:59:24 INFO - PROCESS | 23702 | Browser inner width/height: 1024/697 03:59:24 INFO - PROCESS | 23702 | __metrics 03:59:25 ERROR - PROCESS | 23702 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:59:26 INFO - PROCESS | 23702 | console.error: PushService: 03:59:26 INFO - PROCESS | 23702 | stateChangeProcessEnqueue: Error transitioning state 03:59:26 INFO - PROCESS | 23702 | UnknownError 03:59:26 INFO - TEST-INFO | 23702: exit 0 03:59:26 INFO - Browser initialized. 03:59:26 INFO - Running cycle 1/1 for kraken test... 03:59:26 INFO - TEST-INFO | started process 23793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubGc8h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:38 INFO - PROCESS | 23793 | RSS: Main: 145575936 03:59:38 INFO - PROCESS | 23793 | 03:59:41 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51450/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:41 INFO - PROCESS | 23793 | RSS: Main: 194437120 03:59:41 INFO - PROCESS | 23793 | 03:59:44 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51450/tests/kraken/driver.html?testName=audio-dft) 03:59:45 INFO - PROCESS | 23793 | RSS: Main: 192868352 03:59:45 INFO - PROCESS | 23793 | 03:59:47 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51450/tests/kraken/driver.html?testName=audio-fft) 03:59:48 INFO - PROCESS | 23793 | RSS: Main: 278597632 03:59:48 INFO - PROCESS | 23793 | 03:59:50 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51450/tests/kraken/driver.html?testName=audio-oscillator) 03:59:51 INFO - PROCESS | 23793 | RSS: Main: 187256832 03:59:51 INFO - PROCESS | 23793 | 03:59:53 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:53 INFO - PROCESS | 23793 | RSS: Main: 188567552 03:59:53 INFO - PROCESS | 23793 | 03:59:56 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51450/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:57 INFO - PROCESS | 23793 | RSS: Main: 222416896 03:59:57 INFO - PROCESS | 23793 | 04:00:00 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51450/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:01 INFO - PROCESS | 23793 | RSS: Main: 222613504 04:00:01 INFO - PROCESS | 23793 | 04:00:04 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51450/tests/kraken/driver.html?testName=json-parse-financial) 04:00:04 INFO - PROCESS | 23793 | RSS: Main: 222470144 04:00:04 INFO - PROCESS | 23793 | 04:00:06 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:06 INFO - PROCESS | 23793 | RSS: Main: 201080832 04:00:06 INFO - PROCESS | 23793 | 04:00:08 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:09 INFO - PROCESS | 23793 | RSS: Main: 203010048 04:00:09 INFO - PROCESS | 23793 | 04:00:11 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:11 INFO - PROCESS | 23793 | RSS: Main: 209596416 04:00:11 INFO - PROCESS | 23793 | 04:00:14 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:15 INFO - PROCESS | 23793 | RSS: Main: 216117248 04:00:15 INFO - PROCESS | 23793 | 04:00:17 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:18 INFO - PROCESS | 23793 | RSS: Main: 217051136 04:00:18 INFO - PROCESS | 23793 | 04:00:19 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:51450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51450/tests/kraken/driver.html?testName=ai-astar) 04:00:20 INFO - PROCESS | 23793 | RSS: Main: 259260416 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | __start_tp_report 04:00:20 INFO - PROCESS | 23793 | _x_x_mozilla_page_load 04:00:20 INFO - PROCESS | 23793 | _x_x_mozilla_page_load_details 04:00:20 INFO - PROCESS | 23793 | |i|pagename|runs| 04:00:20 INFO - PROCESS | 23793 | |0;ai-astar;110;105;109;108;109;117;109;109;109;108 04:00:20 INFO - PROCESS | 23793 | |1;audio-beat-detection;152;124;125;178;123;127;149;124;158;122 04:00:20 INFO - PROCESS | 23793 | |2;audio-dft;160;162;160;159;160;163;161;162;160;160 04:00:20 INFO - PROCESS | 23793 | |3;audio-fft;75;75;77;132;75;75;75;74;111;74 04:00:20 INFO - PROCESS | 23793 | |4;audio-oscillator;85;84;118;84;84;84;122;85;85;135 04:00:20 INFO - PROCESS | 23793 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;116;117 04:00:20 INFO - PROCESS | 23793 | |6;imaging-darkroom;146;146;146;147;147;146;146;146;146;148 04:00:20 INFO - PROCESS | 23793 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;94 04:00:20 INFO - PROCESS | 23793 | |8;json-parse-financial;50;51;50;51;51;51;53;51;50;52 04:00:20 INFO - PROCESS | 23793 | |9;json-stringify-tinderbox;65;65;64;65;65;64;65;65;65;64 04:00:20 INFO - PROCESS | 23793 | |10;stanford-crypto-aes;76;75;76;81;84;78;77;76;109;76 04:00:20 INFO - PROCESS | 23793 | |11;stanford-crypto-ccm;118;132;122;117;115;117;117;132;135;118 04:00:20 INFO - PROCESS | 23793 | |12;stanford-crypto-pbkdf2;152;152;152;156;161;154;152;151;149;152 04:00:20 INFO - PROCESS | 23793 | |13;stanford-crypto-sha256-iterative;63;65;62;61;61;61;61;61;60;63 04:00:20 INFO - PROCESS | 23793 | __end_tp_report 04:00:20 INFO - PROCESS | 23793 | __start_cc_report 04:00:20 INFO - PROCESS | 23793 | _x_x_mozilla_cycle_collect,1583 04:00:20 INFO - PROCESS | 23793 | __end_cc_report 04:00:20 INFO - PROCESS | 23793 | __startTimestamp1465815620165__endTimestamp 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | ------- Summary: start ------- 04:00:20 INFO - PROCESS | 23793 | Number of tests: 14 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.00 stddev:3.02 (2.8%) stddev-sans-first:3.19 04:00:20 INFO - PROCESS | 23793 | Values: 110.0 105.0 109.0 108.0 109.0 117.0 109.0 109.0 109.0 108.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:138.00 stddev:19.66 (14.2%) stddev-sans-first:20.21 04:00:20 INFO - PROCESS | 23793 | Values: 152.0 124.0 125.0 178.0 123.0 127.0 149.0 124.0 158.0 122.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 04:00:20 INFO - PROCESS | 23793 | Values: 160.0 162.0 160.0 159.0 160.0 163.0 161.0 162.0 160.0 160.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#3] audio-fft Cycles:10 Average:84.30 Median:75.00 stddev:20.24 (27.0%) stddev-sans-first:21.18 04:00:20 INFO - PROCESS | 23793 | Values: 75.0 75.0 77.0 132.0 75.0 75.0 75.0 74.0 111.0 74.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:20.05 (23.9%) stddev-sans-first:20.82 04:00:20 INFO - PROCESS | 23793 | Values: 85.0 84.0 118.0 84.0 84.0 84.0 122.0 85.0 85.0 135.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:00:20 INFO - PROCESS | 23793 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:00:20 INFO - PROCESS | 23793 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 148.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:00:20 INFO - PROCESS | 23793 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.94 (1.8%) stddev-sans-first:0.93 04:00:20 INFO - PROCESS | 23793 | Values: 50.0 51.0 50.0 51.0 51.0 51.0 53.0 51.0 50.0 52.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:00:20 INFO - PROCESS | 23793 | Values: 65.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:76.50 stddev:10.29 (13.5%) stddev-sans-first:10.77 04:00:20 INFO - PROCESS | 23793 | Values: 76.0 75.0 76.0 81.0 84.0 78.0 77.0 76.0 109.0 76.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:120.00 stddev:7.63 (6.4%) stddev-sans-first:7.93 04:00:20 INFO - PROCESS | 23793 | Values: 118.0 132.0 122.0 117.0 115.0 117.0 117.0 132.0 135.0 118.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:152.00 stddev:3.31 (2.2%) stddev-sans-first:3.49 04:00:20 INFO - PROCESS | 23793 | Values: 152.0 152.0 152.0 156.0 161.0 154.0 152.0 151.0 149.0 152.0 04:00:20 INFO - PROCESS | 23793 | 04:00:20 INFO - PROCESS | 23793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:61.50 stddev:1.48 (2.4%) stddev-sans-first:1.50 04:00:20 INFO - PROCESS | 23793 | Values: 63.0 65.0 62.0 61.0 61.0 61.0 61.0 61.0 60.0 63.0 04:00:20 INFO - PROCESS | 23793 | -------- Summary: end -------- 04:00:20 INFO - PROCESS | 23793 | 04:00:21 INFO - TEST-INFO | 23793: exit 0 04:00:21 INFO - TEST-OK | kraken | took 60057ms 04:00:21 INFO - SUITE-END | took 1172s 04:00:21 INFO - Completed test suite (00:19:33) 04:00:21 INFO - javascript benchmark 04:00:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3284.5894263217097, 3325.7838240514366, 3330.38387898239, 3342.5487559179533, 3369.3092915952216, 5369.301990741203, 5464.890702185954, 5471.179323101537, 5493.533049690781, 5497.120460726284, 5315.335583052119, 5372.865678358034, 5378.569714422846, 5386.838394848151, 5409.107497262957, 4826.855194344175, 4832.87917802056, 4882.731449770261, 4886.731229782361, 4987.551120399164, 4819.0, 4961.305417241589, 5007.549320561149, 5010.498950104997, 5010.574101201402, 4911.8772030699165, 4935.728534930578, 4959.206526955688, 4974.751262436882, 4992.051510213066, 5039.72281524516, 5045.041442125985, 5057.216131499624, 5057.468965758598, 5062.0, 4816.951830481686, 4835.153848076572, 4911.361523002022, 4946.703197808107, 4987.326710894019, 5239.397469291042, 5251.291075704769, 5261.026710058613, 5269.973650131763, 5294.49702278283, 5789.160571717078, 5797.072468405035, 5807.622504537234, 5820.82537523875, 5825.271841019872, 5670.716464176775, 5706.0, 5735.512481439083, 5811.128330750379, 5820.505257053155, 5410.08028635133, 5443.59173062018, 5465.344158700942, 5467.343918729698, 5469.507744303032, 5799.5070419014855, 5922.378150294243, 5925.40745925404, 5930.377310382348, 5936.9406305937255, 5615.550755939515, 5680.744366503517, 5689.886202275931, 5748.885022299614, 5770.682612456271, 5814.389489103668, 5817.127430885401, 5818.883622327615, 5848.736806843703, 5854.502367298742, 5622.91565626516, 5670.971645141748, 5781.739821708034, 5786.07422812348, 5791.88416231673, 5714.05718056516, 5743.511801496836, 5759.884802304015, 5762.711864406763, 5787.305523337142, 4423.469183697976, 4445.488768791631, 4446.888827779331, 4447.644188464915, 4470.642348612103, 3960.6039396060164, 3969.7816620085596, 3972.3842804365368, 3989.5412027616617, 4031.314676505001, 5534.335879694462, 5559.11054231321, 5559.27729395176, 5562.554995600342, 5570.387257401682, 5830.737616807254, 5844.620099693507, 5847.853803654858, 5855.707214639251, 5878.353381128072, 5369.624126311121, 5424.484673955968, 5433.592480563973, 5484.396716361277, 5516.062269414209, 5015.14742493777, 5026.597872170218, 5028.748562571856, 5032.723200224023, 5037.345145131183, 5929.288485381696, 5992.191054207713, 6031.788887388921, 6033.276006879202, 6037.840984283444, 5711.057675483498, 5792.768289268551, 5796.739146738322, 5858.384869588632, 5869.119632055226, 6106.023036314168, 6120.693965301628, 6123.7244324006415, 6125.081237814364, 6128.662923539248, 5820.097884827858, 5830.737616807169, 5832.0085585451425, 5832.883342333044, 5835.591508594358, 5677.8864422710485, 5823.4467725566, 5858.531317494505, 5882.294124705063, 5919.556033297434, 5746.770129194785, 5754.772408161686, 5770.653760774367, 5782.595218334676, 5798.043322851851, 5538.418466061005, 5753.993051215937, 5757.280339957505, 5761.654300741969, 5769.249997500298, 5526.889462210653, 5582.665040097607, 5588.804391846266, 5639.182318563868, 5646.153077038477, 5717.599768016199, 5751.9424805751405, 5762.394948530512, 5767.221425107557, 5770.163326317745, 5468.56251499887, 5512.924979628934, 5553.278073850373, 5636.0, 5653.802116925888], "value": 5368.6245334989735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.3613437823097, 657.5035847934812, 662.678600878574, 669.2571245917035, 673.7473447457204, 33219.16952076199, 45801.54198458019, 45943.5405645943, 46040.309395359014, 46064.76967615157, 49419.75290123553, 50022.24966625503, 50099.24851127236, 50146.24780628293, 50192.49807501924, 8241.95879020607, 8875.467471951672, 9113.544322783868, 9114.13415725505, 10720.410377429238, 10648.62729804457, 10793.460326983659, 10797.514111864946, 10799.190060745435, 10802.351858888453, 10863.891361086407, 10871.184661150406, 10902.182336324768, 10954.671359859178, 10972.286801357886, 8407.033191183, 10803.945980270088, 10806.081483073947, 11049.116070714404, 11086.944565277203, 10573.154147668169, 10992.615258465916, 10993.670189894236, 10994.780104397947, 11000.284981476178, 46278.0, 46657.0, 46883.765581172214, 46960.530394696296, 47080.7645961768, 3706.258748250361, 3760.9469348582443, 3781.8676346327748, 3792.127810603549, 3818.4081467372603, 35511.4673279901, 35852.282954341026, 35873.82063089694, 36031.4595281071, 36165.819170903975, 4373.846915357947, 4698.769464451455, 4776.027766912421, 4788.715522146706, 4842.515748425165, 382717.0, 384444.0777796121, 384831.0, 386748.0, 388750.0, 40812.18375632471, 71733.64133179301, 72258.0, 72514.2748572518, 72583.0, 42136.0, 42192.36711449331, 42392.788036059625, 42419.15161696749, 42474.57525424768, 17748.822511774717, 18148.0, 18160.273589056553, 18184.818151818312, 18191.181396837175, 13459.0, 14901.254937253094, 15107.39570417193, 15129.0, 15554.0, 9294.748467116058, 9396.389234699722, 9431.245500359955, 9489.051094890594, 9527.333086683866, 3604.5494313210847, 3615.6926661233565, 3629.1290090378648, 3655.6344365563764, 3697.5932647408763, 1098.0, 1110.8444817725524, 1125.5835340923911, 1128.0073535288893, 1169.830374595679, 34683.13292167716, 34816.82591587026, 35119.824400877835, 35168.29663406718, 35173.824130879184, 1170.4440390814295, 1197.6886009637558, 1210.6973256685828, 1224.406163010939, 1296.2416986063258, 17981.190846411944, 18152.273909043754, 18161.909190453964, 18165.36421225277, 18213.63572728538, 655403.0, 660264.0, 660662.0, 663144.0, 665411.0, 63193.684031580466, 64703.67648161729, 64974.0, 65077.0, 65138.34861651417, 1328.5018118205674, 1467.4643755029338, 1468.4199741102204, 1479.5191562741936, 1486.472302332678, 33947.4907876387, 34812.82593587117, 35207.82396088003, 35811.10472238215, 36113.63886361103, 54516.727416362664, 55044.724776375864, 55061.174082387995, 55112.0, 55166.44833551613, 350234.0, 356312.0, 356419.0, 357854.0, 358357.0, 27931.72068279291, 29738.70261297446, 30180.0, 30986.380272394876, 31627.367452650356, 52074.73962630163, 52687.0, 53285.46714532805, 53831.73084134554, 54284.0, 43396.56603434052, 43515.34566805419, 44379.55620443754, 44615.55384446114, 45078.0, 43021.569784301755, 43623.0, 43991.0, 44828.55171448244, 45210.0, 43894.56105438905, 44510.55489445194, 45107.0, 45514.0, 45870.0, 38018.429723553614, 38208.80895595504, 38740.6125938737, 38863.80568097141, 39047.6095239044, 29179.85410073021, 29736.702632973393, 29781.5532767013, 29974.023905968843, 30095.0], "value": 20853.15780369577, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.6252933209638, 432.75765571280067, 435.30134134713774, 440.32410250265866, 442.36741459712607, 18318.084095795206, 19737.210511579557, 19812.10845511952, 19903.303384381514, 20110.89944550277, 17457.21442535086, 17679.381221657244, 18189.90816056154, 18348.08259587022, 18410.0, 5656.349519805213, 5871.3541510433815, 5878.764849406019, 5880.411958804107, 5881.264841894763, 4322.913541729164, 5313.442088580682, 5668.433156684319, 5746.48281654651, 6430.48556115512, 6419.582727122722, 6511.967440162793, 6529.902051469232, 6540.313267106957, 6577.046328282396, 6372.267189273247, 6377.904331435032, 6483.805485835433, 6497.5126865485045, 6537.509686773511, 3829.0, 5355.30381050461, 5700.942990570083, 5802.419758024206, 5806.187133801229, 20565.0, 23871.522569548684, 23944.760552394426, 24017.0, 24224.0, 3072.2626569623353, 3148.66938971407, 3209.1014515935576, 3253.9349213015607, 3342.398368293706, 14165.785957845677, 14827.406903723839, 15097.3206205721, 15245.542633720896, 15580.454684086002, 2015.506200980769, 2044.7852975437513, 2057.6913462980524, 2096.9895150524303, 2133.6799480077957, 80084.19915800825, 82414.0, 82934.58532707358, 83100.58449707773, 85033.14966850315, 10976.780464390667, 11098.2786118902, 11326.546938122548, 11513.827292590619, 11562.537498500134, 15926.124063176405, 15980.680386392207, 16060.839391605934, 16062.839371606367, 16105.355785768672, 8610.65557377698, 8768.939299264668, 8845.159709827556, 8859.557022148867, 8908.198262156437, 8480.872786908201, 8504.574771261412, 8583.484990900566, 8671.869921951176, 8699.347548933856, 6984.580925144508, 7015.964920175366, 7055.823604409931, 7153.535020223669, 7165.247648996885, 1909.417627623588, 1935.400025991947, 1938.893360865166, 1978.1493957598084, 1988.9502762430766, 916.2166347772692, 975.9219262458986, 1014.8376259798397, 1085.2240647936605, 1088.4394536813547, 19095.14071866769, 19261.903690481457, 19621.31325403604, 20067.0, 20440.897795510926, 1015.3907655406697, 1031.376017509411, 1052.2266134391216, 1144.6508814811561, 1160.7040204747905, 11125.666230013112, 11739.295642261492, 11762.470688819023, 11765.764684706259, 11770.646880593597, 535912.0, 543862.0, 548663.0, 564368.0, 565216.0, 85242.0, 85643.57178214069, 86214.56892715622, 88292.0, 90933.09066909378, 1051.558345494894, 1064.387976913278, 1079.3847506921136, 1084.143526613982, 1086.7120213143523, 17680.0, 18026.1888215028, 18172.545686357946, 18262.72605910939, 18407.63184736271, 36512.0, 38765.6123438762, 39180.41229381619, 40741.38887916743, 42155.103020363546, 55311.723441382535, 55432.44567554273, 55591.722041389534, 55825.72087139538, 56112.71943640419, 9118.544072796201, 9179.678711245075, 9181.449113053239, 9248.21390181842, 9382.577783999874, 13644.65888352799, 13702.38339274755, 13777.724445511234, 13800.240986745825, 13879.375428105961, 11922.642320730392, 12085.335306558223, 12200.47274708027, 12386.938065309616, 12725.109242352946, 11671.88328116708, 11942.641720748392, 11958.04335653163, 12174.817377739164, 12434.191777534432, 12221.75556488883, 12366.62900112998, 12432.502699891904, 12522.874771252535, 12535.0, 7558.811029724301, 7943.285104340637, 9222.123898229658, 9281.72154835356, 9365.344425890122, 12534.310612916377, 12635.557755478514, 12649.873501265238, 12666.683332916382, 12693.111482196158], "value": 9823.726132607546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.6975600245958, 1559.1502631066069, 1574.669319442917, 1799.7120460726287, 1906.9332573359927, 8907.68823091192, 9261.351705380626, 9292.303077269198, 9548.140667339938, 9552.904470955289, 9266.768330791716, 9436.292278079138, 9443.57503912324, 9446.433214007164, 9455.621775128986, 2193.451637090727, 2445.4864478459544, 2485.515324511721, 2488.5147396257694, 2546.9235922922344, 2465.593177125772, 2474.653548503211, 2482.0816297969777, 2486.664300319461, 2487.2040946897, 2448.791852692523, 2452.4849781545895, 2452.6443665668558, 2455.594826853576, 2478.3184624228393, 2169.403414061138, 2400.627902675088, 2483.875806209682, 2493.0651005872796, 2509.498100379913, 2385.332107010023, 2393.8563686178886, 2395.3053614451787, 2397.988010059956, 2426.211481268595, 9485.857712134324, 9561.569729362196, 9562.0, 9563.139317461393, 9572.904270957271, 5421.674699518042, 5572.192032155355, 5582.051051321285, 5583.497485226349, 5595.692236926968, 3477.913052173716, 3603.0992251937014, 3624.963750362489, 3635.709143268532, 3662.10278481771, 1220.9511619535208, 1244.6577191272472, 1253.5173958026135, 1254.6486983644595, 1267.5310135249924, 12776.744465110645, 13143.539976100887, 13288.402021909038, 13663.18020918748, 13713.862861371457, 4651.2557990722, 4717.410323709536, 4747.192977193886, 4762.59517940972, 4812.494688057704, 10027.598896044077, 10034.64878729241, 10064.899351006543, 10089.0, 10095.444750538643, 4954.281629163823, 5455.454454554592, 5460.890782184413, 5461.563074953994, 5464.890702185934, 5152.252923326097, 5324.547413469821, 5334.279872217278, 5387.568994480433, 5395.757190926339, 3788.0719223790347, 3856.0745421099296, 3884.514435695538, 3906.316394630985, 3935.173613541131, 1169.1757311095657, 1172.3376292394769, 1181.8227265910182, 1182.131133616791, 1204.0367705835472, 954.5847556313026, 968.9418634881789, 980.6175591519313, 990.5839547390113, 994.472929347447, 5953.166556682068, 5999.910001349983, 6126.0, 6547.869042619121, 6566.704498297588, 1013.280570794744, 1068.5992752717732, 1094.5949998500605, 1112.6495154026456, 1149.3850789827402, 4258.1483703258855, 4351.06452112791, 4368.0, 4413.911721765547, 4513.119941611354, 11103.0, 11962.162648614514, 12265.141440099285, 12282.508699651913, 12285.508579656713, 11550.826737598944, 11709.648710538697, 11892.286462812259, 11989.0, 12021.038316934624, 8790.86813697795, 8871.600777965006, 8916.108389161032, 8927.508987005647, 8971.05803890595, 6257.937420625917, 6312.905306420499, 6335.334789847, 6411.070394792636, 6527.05357723118, 10702.625408110678, 10851.45742712877, 10897.509612067635, 11037.834432483358, 11186.496607652838, 10872.238943273895, 11304.039156671775, 11417.771644567229, 11418.771624567627, 11433.0, 8348.791280218044, 8587.355948303777, 8597.914020859711, 8600.569971501274, 8763.3427492937, 8812.60343284541, 9040.819183616422, 9337.439753614804, 9350.438973661601, 9520.666776662783, 8192.467489613156, 8280.958595206985, 8292.37807164453, 8386.874196886929, 8545.017323007934, 8166.754997350089, 8262.049864265686, 8392.496450213006, 8467.49195048299, 8496.915030849612, 7532.472726909064, 7592.8481430372185, 7620.314171724572, 7624.885626715492, 7635.045619297588, 5493.038718224375, 5510.448955104457, 5574.275344205227, 5649.68926709035, 5726.79956201531, 5538.307711536058, 5553.694546799965, 5572.777088916398, 5580.609357344947, 5639.943600563942], "value": 4937.18608271575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.2355159957691, 358.2762819105409, 358.45156909927806, 359.18106716685963, 361.2666287436503, 5518.475744804242, 5567.944320556799, 5579.944200557993, 5607.4112218217115, 5624.7906700059475, 5456.781728730846, 5491.697956612385, 5497.39528651848, 5497.780088796453, 5530.557555395569, 3995.2009598080353, 4079.3473044312914, 4356.782160891943, 4381.255186618282, 4391.5827996340295, 4315.352697095445, 4335.241332766753, 4355.738655680653, 4370.978145109286, 4376.912461750763, 4131.938020929689, 4301.935470967938, 4331.198728235271, 4340.218760623086, 4344.695871289011, 4152.425241875532, 4375.14684636496, 4377.496587892401, 4381.824727010916, 4390.473143222818, 3878.3212937735784, 3882.2429626222897, 3890.2688303704863, 3893.1240470894104, 3901.551321598024, 5114.514121158484, 5268.81559145428, 5282.0, 5300.0, 5305.3818585331455, 4947.876303092416, 4947.9505204947845, 4954.083494553519, 4958.479359667219, 4958.553730164303, 5625.6905870177125, 5652.886942261173, 5667.603267771257, 5708.20085188074, 5754.395788442237, 4096.201240758053, 4251.829926802924, 4272.893177670583, 4290.678199135046, 4292.377605247253, 5910.320313163998, 5910.468057874769, 5927.599322274443, 5929.911051334234, 5957.8808423831715, 4304.203722311382, 4321.157374311979, 4326.091520780671, 4359.346098085249, 4376.431063961728, 4301.333293339538, 4427.358033085185, 4427.959429534057, 4452.376667266585, 4487.326900964816, 4941.2835138905375, 4966.1061009018, 4975.5522003019905, 4976.527229913225, 4976.950230497721, 5727.0836666134055, 5746.454086861741, 5753.784792854781, 5769.971150144306, 5794.739236734273, 1500.5948393933577, 1527.5111964171358, 1540.7688846673088, 1542.0978727444347, 1548.9699349932168, 972.8978457262027, 975.8975307592742, 984.4831463481729, 990.7424069741775, 1050.8755631474403, 5533.861653458695, 5581.246531718247, 5590.832275031756, 5593.580481463907, 5618.297712785902, 5864.533866533367, 5875.441833025856, 5875.941240587625, 5905.080848724182, 5906.527477801766, 5457.690154363004, 5562.888742225133, 5570.498655121059, 5588.6646801192055, 5617.662940223599, 3117.2830249042845, 3121.282105115836, 3129.2959084206327, 3149.10250578584, 3155.2269693925136, 5797.130430435468, 6042.728077236535, 6050.334463209044, 6058.666773327421, 6092.527259462153, 5984.31180414258, 6003.3996600339615, 6014.8195554133445, 6020.789272375446, 6033.095035744585, 6038.879222415615, 6078.908816367758, 6080.908786368208, 6092.45167934888, 6099.359567245376, 5765.538756899522, 5863.560232982629, 5933.884710527008, 5964.761409543743, 5974.492168165754, 5781.797637082682, 5789.9710501447225, 5790.392008839011, 5807.564432667651, 5820.534357251325, 5891.0, 5995.370486098896, 6053.485453736482, 6059.303180134341, 6061.545384096298, 4228.725132866354, 4275.251830929637, 4284.078923031563, 4286.549912259168, 4321.114171594879, 5783.855403614775, 5854.180414742024, 5908.291005079418, 5917.846020026226, 5935.0, 5499.257600223918, 5678.438429431939, 5696.259486266758, 5731.054376027909, 5759.481646651821, 5673.77304907799, 5680.318361796611, 5684.63049901755, 5694.174344720075, 5704.771809127588, 5260.868478288074, 5420.593455490775, 5609.158626206102, 5663.008973429715, 5666.46168613981, 5723.6851973141875, 5799.362070172193, 5801.94198058014, 5817.854553636193, 5837.94162058391, 5651.88696226065, 5679.488846003879, 5690.317161940594, 5701.116326969326, 5719.428057194247], "value": 4422.140357466786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.6971135824062, 825.1954344514098, 837.5728378526951, 841.9031811341694, 895.8745775591415, 15838.76241856373, 16140.757888631666, 16349.346026158953, 17531.38640147595, 17611.29554817809, 15953.601159971007, 15958.441454549093, 16043.278052487636, 16111.597210069755, 16119.516414507583, 742.9182789893107, 863.6415887406719, 875.2735229759301, 882.3206131278912, 887.6582515731458, 874.4403581707712, 876.0844917061654, 879.0155026370473, 881.1276835932413, 882.0694167653123, 915.6886658536097, 918.5682729117304, 920.4339331311262, 920.6961702638114, 920.7836158502746, 760.3726925286661, 899.1458114790942, 919.1268295119596, 919.9862002069974, 921.5622579274791, 677.109600874848, 677.7492327838731, 677.7526202935942, 677.8034370032734, 677.989830152548, 15930.362785488567, 15983.760243596354, 16009.199540023068, 16014.599635009217, 16020.439284624983, 15488.380464781396, 15537.611559711098, 15574.610634734108, 15829.050256984618, 15865.286062127232, 13176.934115329457, 13700.65748356289, 13769.31153442324, 13864.792028119486, 13921.164730116225, 4751.3348131261655, 4752.405949256343, 4755.310479980418, 4800.591949684281, 4936.136176169156, 73074.26925730781, 74304.62847685836, 74949.0, 75277.0, 75373.0, 12129.514819407124, 12158.756824863452, 12312.938435307766, 12314.13801033919, 12417.565385211474, 21432.678509822366, 21605.135794568356, 21645.35063948084, 21751.45621359447, 22693.205737799097, 8928.642854285756, 8999.19007289347, 8999.685011024583, 9142.131497507726, 9207.0, 4981.701097934063, 4993.550580447777, 5014.147594908874, 5047.159301893798, 5098.5411312982005, 3738.27103714773, 3881.165549406891, 3885.339492286318, 3889.416587511839, 3893.0267433141717, 665.1489656537643, 669.8794217040881, 671.2817285504464, 679.296927679849, 681.877262092828, 660.4386271669139, 685.1127789512593, 691.7302252121676, 719.521518190408, 731.7841236835146, 9350.90649093514, 9659.90340096604, 9700.466474343979, 9751.561179746928, 9833.901660983442, 640.2157357237347, 707.3563057617544, 720.1933834105835, 724.1816747075876, 729.759179470784, 4503.617192538605, 4528.682992190515, 4654.534546545318, 4682.672212945061, 4729.43246810385, 118769.0, 119463.0, 119552.40223799, 119592.0, 120050.3997480007, 99938.0, 101332.49333753284, 101517.49241253747, 102226.0, 103842.48078759709, 69489.0, 91489.54255228682, 92133.07866921379, 93779.53110234404, 94662.0, 8670.56918669822, 8835.0, 8896.0, 8948.149925757043, 9050.637974480947, 53959.46040539701, 54387.18419223794, 54641.453585463634, 56606.018789342175, 56698.14952775629, 72447.63776181085, 80507.59746201232, 82127.58936205281, 82987.0, 83427.0, 11311.830322545333, 11641.883581164419, 11868.76262474763, 12347.0, 12632.332329346962, 13403.195808251536, 13634.727305454035, 13754.449822007007, 13858.514951976633, 14196.077254978394, 10705.625303114353, 10963.671089867317, 13146.145500542434, 13218.735625287633, 13412.463501459832, 13434.596962091153, 13595.592132236048, 13908.37412316428, 13987.510437134652, 13987.720245595234, 13259.0, 13791.10357826738, 13798.0, 13816.309184540532, 13852.722945541234, 12003.81994270104, 12160.391980400767, 12539.24764514132, 12629.621111366674, 12694.873051269738, 12165.391730413266, 12737.0, 12826.294553799631, 12934.741305173655, 13070.215787052808], "value": 7897.379108722259, "unit": "score"}], "name": "dromaeo_css", "value": 7579.80855546078, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 109.0, 108.0, 109.0, 117.0, 109.0, 109.0, 109.0, 108.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 125.0, 178.0, 123.0, 127.0, 149.0, 124.0, 158.0, 122.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 159.0, 160.0, 163.0, 161.0, 162.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 132.0, 75.0, 75.0, 75.0, 74.0, 111.0, 74.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 118.0, 84.0, 84.0, 84.0, 122.0, 85.0, 85.0, 135.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 148.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 51.0, 51.0, 51.0, 53.0, 51.0, 50.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 81.0, 84.0, 78.0, 77.0, 76.0, 109.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 132.0, 122.0, 117.0, 115.0, 117.0, 117.0, 132.0, 135.0, 118.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 152.0, 156.0, 161.0, 154.0, 152.0, 151.0, 149.0, 152.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 63.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1480.7999999999997, "alertThreshold": 2.0}]} 04:00:21 INFO - Return code: 0 04:00:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:21 ERROR - # TBPL SUCCESS # 04:00:21 INFO - Running post-action listener: _resource_record_post_action 04:00:21 INFO - ##### 04:00:21 INFO - ##### Finished run-tests step (success) 04:00:21 INFO - ##### 04:00:21 INFO - Running post-run listener: _resource_record_post_run 04:00:21 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 252243968; Read time: 180; Write time: 124216 04:00:21 INFO - TinderboxPrint: CPU usage
13.0% 04:00:21 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 180 04:00:21 INFO - TinderboxPrint: I/O write bytes / time
252,243,968 / 124,216 04:00:21 INFO - TinderboxPrint: CPU idle
8,258.4 (86.9%) 04:00:21 INFO - TinderboxPrint: CPU user
1,196.0 (12.6%) 04:00:21 INFO - TinderboxPrint: Swap in / out
0 / 0 04:00:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1245184; Read time: 0; Write time: 72 04:00:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 270336; Write bytes: 250998784; Read time: 180; Write time: 124144 04:00:22 INFO - Running post-run listener: _upload_blobber_files 04:00:22 INFO - Blob upload gear active. 04:00:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:22 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 04:00:22 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'] 04:00:22 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 04:00:22 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:23 INFO - (blobuploader) - INFO - Done attempting. 04:00:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:24 INFO - (blobuploader) - INFO - Done attempting. 04:00:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:28 INFO - (blobuploader) - INFO - Done attempting. 04:00:28 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:28 INFO - Return code: 0 04:00:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9a6a385a14c57000a93c4d68d999fd55c3da293dcf4e002763d8c387472a02ca2cc392520052570fa97f9df4d74bc93023e08458476087febfa88922084691a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd79b3f3e164c61bd282a9e6469fdc1782849884bf3cc276afaf0de65bf4e9b7c24d7a1b1ef9689f66b91f63ac9c8506badbffc9f79d2066eca49b514dcfa2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a289be4f0b8b897b000c0cb9d0fab14241fa64d0e2ddc4ef0ae682d40ddb7e7b8b239fda43e270a46aa3e4aa0e1b0040e9c1c81ab221dea4bab755f54772326"} 04:00:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:28 INFO - Contents: 04:00:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9a6a385a14c57000a93c4d68d999fd55c3da293dcf4e002763d8c387472a02ca2cc392520052570fa97f9df4d74bc93023e08458476087febfa88922084691a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd79b3f3e164c61bd282a9e6469fdc1782849884bf3cc276afaf0de65bf4e9b7c24d7a1b1ef9689f66b91f63ac9c8506badbffc9f79d2066eca49b514dcfa2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a289be4f0b8b897b000c0cb9d0fab14241fa64d0e2ddc4ef0ae682d40ddb7e7b8b239fda43e270a46aa3e4aa0e1b0040e9c1c81ab221dea4bab755f54772326"} 04:00:28 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:28 INFO - Copying logs to upload dir... 04:00:28 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.614558 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-13 04:00:27.822931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 04:00:27.826909) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993 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/a9a6a385a14c57000a93c4d68d999fd55c3da293dcf4e002763d8c387472a02ca2cc392520052570fa97f9df4d74bc93023e08458476087febfa88922084691a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd79b3f3e164c61bd282a9e6469fdc1782849884bf3cc276afaf0de65bf4e9b7c24d7a1b1ef9689f66b91f63ac9c8506badbffc9f79d2066eca49b514dcfa2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a289be4f0b8b897b000c0cb9d0fab14241fa64d0e2ddc4ef0ae682d40ddb7e7b8b239fda43e270a46aa3e4aa0e1b0040e9c1c81ab221dea4bab755f54772326"} build_url:https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/I6xBeWcARfG8Upi6by5mTQ/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/a9a6a385a14c57000a93c4d68d999fd55c3da293dcf4e002763d8c387472a02ca2cc392520052570fa97f9df4d74bc93023e08458476087febfa88922084691a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd79b3f3e164c61bd282a9e6469fdc1782849884bf3cc276afaf0de65bf4e9b7c24d7a1b1ef9689f66b91f63ac9c8506badbffc9f79d2066eca49b514dcfa2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a289be4f0b8b897b000c0cb9d0fab14241fa64d0e2ddc4ef0ae682d40ddb7e7b8b239fda43e270a46aa3e4aa0e1b0040e9c1c81ab221dea4bab755f54772326"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 04:00:27.852324) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 04:00:27.852909) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465812327.13323-1938130993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 04:00:27.936680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 04:00:27.937032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 04:00:27.937360) ========= ========= Total master_lag: 0.16 =========