builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1467038619.49 results: success (0) buildid: 20160627051226 builduid: 7fe53ab308b448259be9798e08324dc8 revision: 852f817ca2c4a23f0736c4407305341adbc99904 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.494216) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.494806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.495092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.588560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.588853) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 07:43: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-06-27 07:43:40 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.738130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.738418) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.788591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:39.788904) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 852f817ca2c4a23f0736c4407305341adbc99904 --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 852f817ca2c4a23f0736c4407305341adbc99904 --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=934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 07:43:40,217 truncating revision to first 12 chars 2016-06-27 07:43:40,217 Setting DEBUG logging. 2016-06-27 07:43:40,217 attempt 1/10 2016-06-27 07:43:40,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/852f817ca2c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 07:43:40,537 unpacking tar archive at: mozilla-aurora-852f817ca2c4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643969 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:40.451611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:40.451938) ========= script_repo_revision: 852f817ca2c4a23f0736c4407305341adbc99904 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:40.452358) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:40.452619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:43:40.463542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-27 07:43:40.463816) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:43:40 INFO - MultiFileLogger online at 20160627 07:43:40 in /builds/slave/test 07:43: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 07:43:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:43:40 INFO - {'append_to_log': False, 07:43:40 INFO - 'base_work_dir': '/builds/slave/test', 07:43:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:43:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:43:40 INFO - 'branch': 'Mozilla-Aurora', 07:43:40 INFO - 'buildbot_json_path': 'buildprops.json', 07:43:40 INFO - 'config_files': ('talos/linux_config.py',), 07:43:40 INFO - 'default_actions': ('clobber', 07:43:40 INFO - 'read-buildbot-config', 07:43:40 INFO - 'download-and-extract', 07:43:40 INFO - 'populate-webroot', 07:43:40 INFO - 'create-virtualenv', 07:43:40 INFO - 'install', 07:43:40 INFO - 'run-tests'), 07:43:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:43:40 INFO - 'download_minidump_stackwalk': True, 07:43:40 INFO - 'download_symbols': 'ondemand', 07:43:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:43:40 INFO - 'tooltool.py': '/tools/tooltool.py', 07:43:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:43:40 INFO - '/tools/misc-python/virtualenv.py')}, 07:43:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:43:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:43:40 INFO - 'installer_path': 'installer.exe', 07:43:40 INFO - 'log_level': 'info', 07:43:40 INFO - 'log_name': 'talos', 07:43:40 INFO - 'log_to_console': True, 07:43:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:43:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:43:40 INFO - 'opt_config_files': (), 07:43:40 INFO - 'pip_index': False, 07:43:40 INFO - 'sps_profile': False, 07:43:40 INFO - 'sps_profile_interval': 0, 07:43:40 INFO - 'suite': 'dromaeojs', 07:43:40 INFO - 'system_bits': '32', 07:43:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:43:40 INFO - 'title': 'talos-linux64-ix-057', 07:43:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:43:40 INFO - 'use_talos_json': True, 07:43:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:43:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:43:40 INFO - 'work_dir': 'build'} 07:43:40 INFO - ##### 07:43:40 INFO - ##### Running clobber step. 07:43:40 INFO - ##### 07:43:40 INFO - Running pre-action listener: _resource_record_pre_action 07:43:40 INFO - Running main action method: clobber 07:43:40 INFO - rmtree: /builds/slave/test/build 07:43:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:43:41 INFO - Running post-action listener: _resource_record_post_action 07:43:41 INFO - ##### 07:43:41 INFO - ##### Finished clobber step (success) 07:43:41 INFO - ##### 07:43:41 INFO - ##### 07:43:41 INFO - ##### Running read-buildbot-config step. 07:43:41 INFO - ##### 07:43:41 INFO - Running pre-action listener: _resource_record_pre_action 07:43:41 INFO - Running main action method: read_buildbot_config 07:43:41 INFO - Using buildbot properties: 07:43:41 INFO - { 07:43:41 INFO - "project": "", 07:43:41 INFO - "product": "firefox", 07:43:41 INFO - "script_repo_revision": "production", 07:43:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:43:41 INFO - "repository": "", 07:43:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:43:41 INFO - "buildid": "20160627051226", 07:43:41 INFO - "pgo_build": "True", 07:43:41 INFO - "basedir": "/builds/slave/test", 07:43:41 INFO - "buildnumber": 579, 07:43:41 INFO - "slavename": "talos-linux64-ix-057", 07:43:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:43:41 INFO - "platform": "ubuntu64_hw", 07:43:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:43:41 INFO - "branch": "mozilla-aurora", 07:43:41 INFO - "repo_path": "releases/mozilla-aurora", 07:43:41 INFO - "revision": "852f817ca2c4a23f0736c4407305341adbc99904", 07:43:41 INFO - "stage_platform": "linux64-pgo", 07:43:41 INFO - "builduid": "7fe53ab308b448259be9798e08324dc8", 07:43:41 INFO - "slavebuilddir": "test" 07:43:41 INFO - } 07:43:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 07:43:41 INFO - Running post-action listener: _resource_record_post_action 07:43:41 INFO - ##### 07:43:41 INFO - ##### Finished read-buildbot-config step (success) 07:43:41 INFO - ##### 07:43:41 INFO - ##### 07:43:41 INFO - ##### Running download-and-extract step. 07:43:41 INFO - ##### 07:43:41 INFO - Running pre-action listener: _resource_record_pre_action 07:43:41 INFO - Running main action method: download_and_extract 07:43:41 INFO - mkdir: /builds/slave/test/build/tests 07:43: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')]} 07:43:41 INFO - https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:43:44 INFO - Downloaded 1361 bytes. 07:43:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:43:44 INFO - Using the following test package requirements: 07:43:44 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:43:44 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:43:44 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:43:44 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'jsshell-linux-x86_64.zip'], 07:43:44 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:43:44 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:43:44 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:43:44 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:43:44 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:43:44 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:43:44 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:44 INFO - https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:43:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:43:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:43:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:43:54 INFO - Downloaded 24523655 bytes. 07:43:54 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'] 07:43:54 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 07:43:55 INFO - Return code: 0 07:43:55 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 07:43:55 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')]} 07:43:55 INFO - https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:43:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:43:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:43:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:43:59 INFO - Downloaded 24523655 bytes. 07:43:59 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'] 07:43:59 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 07:44:01 INFO - Return code: 0 07:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:01 INFO - https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:44:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:44:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:44:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:44:02 INFO - Downloaded 10833369 bytes. 07:44:02 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'] 07:44:02 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 07:44:02 INFO - Return code: 0 07:44: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')]} 07:44:02 INFO - https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FK-vFQT4R4mn14bhZuyNVA/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 07:44:04 INFO - Downloaded 63609983 bytes. 07:44:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:44:04 INFO - mkdir: /builds/slave/test/properties 07:44:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:04 INFO - Contents: 07:44:04 INFO - build_url:https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:44:05 INFO - Running post-action listener: _resource_record_post_action 07:44:05 INFO - Running post-action listener: set_extra_try_arguments 07:44:05 INFO - ##### 07:44:05 INFO - ##### Finished download-and-extract step (success) 07:44:05 INFO - ##### 07:44:05 INFO - ##### 07:44:05 INFO - ##### Running populate-webroot step. 07:44:05 INFO - ##### 07:44:05 INFO - Running pre-action listener: _resource_record_pre_action 07:44:05 INFO - Running main action method: populate_webroot 07:44:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:05 INFO - '--tppagecycles', 07:44:05 INFO - '7'], 07:44:05 INFO - 'tests': ['tsvgm']}}, 07:44:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['damp', 'tps']}, 07:44:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'tests': ['damp', 'tps']}, 07:44:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['dromaeo_dom']}, 07:44:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tsvgx', 07:44:05 INFO - 'tsvgr_opacity', 07:44:05 INFO - 'tart', 07:44:05 INFO - 'tscrollx', 07:44:05 INFO - 'cart']}, 07:44:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:05 INFO - 'tsvgr_opacity', 07:44:05 INFO - 'tart', 07:44:05 INFO - 'tscrollx', 07:44:05 INFO - 'cart']}, 07:44:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tp5o']}, 07:44:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'tests': ['tp5o']}, 07:44:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s', 07:44:05 INFO - '--xperf_path', 07:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:05 INFO - 'tests': ['tp5n']}, 07:44:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--xperf_path', 07:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:05 INFO - 'tests': ['tp5n']}}, 07:44:05 INFO - 'talos.zip': {'path': '', 07:44:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:05 INFO - Running post-action listener: _resource_record_post_action 07:44:05 INFO - ##### 07:44:05 INFO - ##### Finished populate-webroot step (success) 07:44:05 INFO - ##### 07:44:05 INFO - ##### 07:44:05 INFO - ##### Running create-virtualenv step. 07:44:05 INFO - ##### 07:44:05 INFO - Running pre-action listener: _resource_record_pre_action 07:44:05 INFO - Running main action method: create_virtualenv 07:44:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:05 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 07:44:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:05 INFO - Using real prefix '/usr' 07:44:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:05 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:07 INFO - Installing pip.................done. 07:44:07 INFO - Return code: 0 07:44:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:07 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 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:07 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 07:44:07 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 07:44:07 INFO - Using env: {'DISPLAY': ':0', 07:44:07 INFO - 'HOME': '/home/cltbld', 07:44:07 INFO - 'LANG': 'en_US.UTF-8', 07:44:07 INFO - 'LANGUAGE': 'en_US:en', 07:44:07 INFO - 'LOGNAME': 'cltbld', 07:44:07 INFO - 'MAIL': '/var/mail/cltbld', 07:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:07 INFO - 'MOZ_NO_REMOTE': '1', 07:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:07 INFO - 'NO_EM_RESTART': '1', 07:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:07 INFO - 'PWD': '/builds/slave/test', 07:44:07 INFO - 'SHELL': '/bin/bash', 07:44:07 INFO - 'SHLVL': '1', 07:44:07 INFO - 'TERM': 'linux', 07:44:07 INFO - 'TMOUT': '86400', 07:44:07 INFO - 'USER': 'cltbld', 07:44:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:07 INFO - '_': '/tools/buildbot/bin/python'} 07:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:07 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 07:44:07 INFO - Cleaning up... 07:44:07 INFO - Return code: 0 07:44:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:07 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 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:07 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 07:44:07 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 07:44:07 INFO - Using env: {'DISPLAY': ':0', 07:44:07 INFO - 'HOME': '/home/cltbld', 07:44:07 INFO - 'LANG': 'en_US.UTF-8', 07:44:07 INFO - 'LANGUAGE': 'en_US:en', 07:44:07 INFO - 'LOGNAME': 'cltbld', 07:44:07 INFO - 'MAIL': '/var/mail/cltbld', 07:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:07 INFO - 'MOZ_NO_REMOTE': '1', 07:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:07 INFO - 'NO_EM_RESTART': '1', 07:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:07 INFO - 'PWD': '/builds/slave/test', 07:44:07 INFO - 'SHELL': '/bin/bash', 07:44:07 INFO - 'SHLVL': '1', 07:44:07 INFO - 'TERM': 'linux', 07:44:07 INFO - 'TMOUT': '86400', 07:44:07 INFO - 'USER': 'cltbld', 07:44:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:07 INFO - '_': '/tools/buildbot/bin/python'} 07:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:08 INFO - Downloading/unpacking psutil>=3.1.1 07:44:08 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 07:44:08 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 07:44:08 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 07:44:08 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 07:44:08 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 07:44:08 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 07:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:10 INFO - Installing collected packages: psutil 07:44:10 INFO - Running setup.py install for psutil 07:44:10 INFO - building 'psutil._psutil_linux' extension 07:44:10 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 07:44:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:44:10 INFO - building 'psutil._psutil_posix' extension 07:44:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:44:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:10 INFO - Successfully installed psutil 07:44:10 INFO - Cleaning up... 07:44:10 INFO - Return code: 0 07:44:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:44:10 INFO - Using env: {'DISPLAY': ':0', 07:44:10 INFO - 'HOME': '/home/cltbld', 07:44:10 INFO - 'LANG': 'en_US.UTF-8', 07:44:10 INFO - 'LANGUAGE': 'en_US:en', 07:44:10 INFO - 'LOGNAME': 'cltbld', 07:44:10 INFO - 'MAIL': '/var/mail/cltbld', 07:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:10 INFO - 'MOZ_NO_REMOTE': '1', 07:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:10 INFO - 'NO_EM_RESTART': '1', 07:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:10 INFO - 'PWD': '/builds/slave/test', 07:44:10 INFO - 'SHELL': '/bin/bash', 07:44:10 INFO - 'SHLVL': '1', 07:44:10 INFO - 'TERM': 'linux', 07:44:10 INFO - 'TMOUT': '86400', 07:44:10 INFO - 'USER': 'cltbld', 07:44:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:10 INFO - '_': '/tools/buildbot/bin/python'} 07:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:13 INFO - Installing collected packages: mozsystemmonitor 07:44:13 INFO - Running setup.py install for mozsystemmonitor 07:44:13 INFO - Successfully installed mozsystemmonitor 07:44:13 INFO - Cleaning up... 07:44:13 INFO - Return code: 0 07:44:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:44:13 INFO - Using env: {'DISPLAY': ':0', 07:44:13 INFO - 'HOME': '/home/cltbld', 07:44:13 INFO - 'LANG': 'en_US.UTF-8', 07:44:13 INFO - 'LANGUAGE': 'en_US:en', 07:44:13 INFO - 'LOGNAME': 'cltbld', 07:44:13 INFO - 'MAIL': '/var/mail/cltbld', 07:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:13 INFO - 'MOZ_NO_REMOTE': '1', 07:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:13 INFO - 'NO_EM_RESTART': '1', 07:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:13 INFO - 'PWD': '/builds/slave/test', 07:44:13 INFO - 'SHELL': '/bin/bash', 07:44:13 INFO - 'SHLVL': '1', 07:44:13 INFO - 'TERM': 'linux', 07:44:13 INFO - 'TMOUT': '86400', 07:44:13 INFO - 'USER': 'cltbld', 07:44:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:13 INFO - '_': '/tools/buildbot/bin/python'} 07:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:13 INFO - Downloading/unpacking jsonschema==2.5.1 07:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:15 INFO - warning: no files found matching '*.txt' 07:44:15 INFO - no previously-included directories found matching 'build' 07:44:15 INFO - no previously-included directories found matching 'dist' 07:44:15 INFO - no previously-included directories found matching '.git*' 07:44:15 INFO - Installing collected packages: jsonschema, functools32 07:44:15 INFO - Running setup.py install for functools32 07:44:16 INFO - warning: no files found matching '*.txt' 07:44:16 INFO - no previously-included directories found matching 'build' 07:44:16 INFO - no previously-included directories found matching 'dist' 07:44:16 INFO - no previously-included directories found matching '.git*' 07:44:16 INFO - Successfully installed jsonschema functools32 07:44:16 INFO - Cleaning up... 07:44:16 INFO - Return code: 0 07:44:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44: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 07:44: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 07:44:16 INFO - Using env: {'DISPLAY': ':0', 07:44:16 INFO - 'HOME': '/home/cltbld', 07:44:16 INFO - 'LANG': 'en_US.UTF-8', 07:44:16 INFO - 'LANGUAGE': 'en_US:en', 07:44:16 INFO - 'LOGNAME': 'cltbld', 07:44:16 INFO - 'MAIL': '/var/mail/cltbld', 07:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:16 INFO - 'MOZ_NO_REMOTE': '1', 07:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:16 INFO - 'NO_EM_RESTART': '1', 07:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:16 INFO - 'PWD': '/builds/slave/test', 07:44:16 INFO - 'SHELL': '/bin/bash', 07:44:16 INFO - 'SHLVL': '1', 07:44:16 INFO - 'TERM': 'linux', 07:44:16 INFO - 'TMOUT': '86400', 07:44:16 INFO - 'USER': 'cltbld', 07:44:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:16 INFO - '_': '/tools/buildbot/bin/python'} 07:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:16 INFO - Downloading/unpacking blobuploader==1.2.4 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:18 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:18 INFO - Downloading docopt-0.6.1.tar.gz 07:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:18 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:18 INFO - Running setup.py install for blobuploader 07:44:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:19 INFO - Running setup.py install for requests 07:44:19 INFO - Running setup.py install for docopt 07:44:19 INFO - Successfully installed blobuploader requests docopt 07:44:19 INFO - Cleaning up... 07:44:19 INFO - Return code: 0 07:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:44:19 INFO - Using env: {'DISPLAY': ':0', 07:44:19 INFO - 'HOME': '/home/cltbld', 07:44:19 INFO - 'LANG': 'en_US.UTF-8', 07:44:19 INFO - 'LANGUAGE': 'en_US:en', 07:44:19 INFO - 'LOGNAME': 'cltbld', 07:44:19 INFO - 'MAIL': '/var/mail/cltbld', 07:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:19 INFO - 'MOZ_NO_REMOTE': '1', 07:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:19 INFO - 'NO_EM_RESTART': '1', 07:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:19 INFO - 'PWD': '/builds/slave/test', 07:44:19 INFO - 'SHELL': '/bin/bash', 07:44:19 INFO - 'SHLVL': '1', 07:44:19 INFO - 'TERM': 'linux', 07:44:19 INFO - 'TMOUT': '86400', 07:44:19 INFO - 'USER': 'cltbld', 07:44:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:19 INFO - '_': '/tools/buildbot/bin/python'} 07:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:19 INFO - Running setup.py (path:/tmp/pip-I92_k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:19 INFO - Running setup.py (path:/tmp/pip-AoEw9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:19 INFO - Running setup.py (path:/tmp/pip-TAuYA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:20 INFO - Running setup.py (path:/tmp/pip-Z_QAJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:20 INFO - Running setup.py (path:/tmp/pip-fT9cE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:20 INFO - Running setup.py (path:/tmp/pip-nMSP7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:20 INFO - Running setup.py (path:/tmp/pip-ffiHUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:20 INFO - Running setup.py (path:/tmp/pip-JSmZnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:20 INFO - Running setup.py (path:/tmp/pip-bpbvhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:20 INFO - Running setup.py (path:/tmp/pip-B5ZjqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:20 INFO - Running setup.py (path:/tmp/pip-G151pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:20 INFO - Running setup.py (path:/tmp/pip-cz9uko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:20 INFO - Running setup.py (path:/tmp/pip-A_7Nin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:20 INFO - Running setup.py (path:/tmp/pip-vbCOK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:20 INFO - Running setup.py (path:/tmp/pip-qNQlFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:20 INFO - Running setup.py (path:/tmp/pip-5Sd0wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:20 INFO - Running setup.py (path:/tmp/pip-i9349N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:21 INFO - Running setup.py install for manifestparser 07:44:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Running setup.py install for mozcrash 07:44:21 INFO - Running setup.py install for mozdebug 07:44:21 INFO - Running setup.py install for mozdevice 07:44:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Running setup.py install for mozfile 07:44:21 INFO - Running setup.py install for mozhttpd 07:44:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Running setup.py install for mozinfo 07:44:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Running setup.py install for mozInstall 07:44:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:21 INFO - Running setup.py install for mozleak 07:44:21 INFO - Running setup.py install for mozlog 07:44:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Running setup.py install for moznetwork 07:44:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Running setup.py install for mozprocess 07:44:22 INFO - Running setup.py install for mozprofile 07:44:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Running setup.py install for mozrunner 07:44:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Running setup.py install for mozscreenshot 07:44:22 INFO - Running setup.py install for moztest 07:44:22 INFO - Running setup.py install for mozversion 07:44:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:22 INFO - Cleaning up... 07:44:22 INFO - Return code: 0 07:44:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:44:22 INFO - Using env: {'DISPLAY': ':0', 07:44:22 INFO - 'HOME': '/home/cltbld', 07:44:22 INFO - 'LANG': 'en_US.UTF-8', 07:44:22 INFO - 'LANGUAGE': 'en_US:en', 07:44:22 INFO - 'LOGNAME': 'cltbld', 07:44:22 INFO - 'MAIL': '/var/mail/cltbld', 07:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:22 INFO - 'MOZ_NO_REMOTE': '1', 07:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:22 INFO - 'NO_EM_RESTART': '1', 07:44:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:22 INFO - 'PWD': '/builds/slave/test', 07:44:22 INFO - 'SHELL': '/bin/bash', 07:44:22 INFO - 'SHLVL': '1', 07:44:22 INFO - 'TERM': 'linux', 07:44:22 INFO - 'TMOUT': '86400', 07:44:22 INFO - 'USER': 'cltbld', 07:44:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:22 INFO - '_': '/tools/buildbot/bin/python'} 07:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:23 INFO - Running setup.py (path:/tmp/pip-Sh4D5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44: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)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:23 INFO - Running setup.py (path:/tmp/pip-wJ7A_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44: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)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:23 INFO - Running setup.py (path:/tmp/pip-D3BROH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:23 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)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:23 INFO - Running setup.py (path:/tmp/pip-pV_FFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:23 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)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:23 INFO - Running setup.py (path:/tmp/pip-yaJx3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:23 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)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:23 INFO - Running setup.py (path:/tmp/pip-MWZwxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:23 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)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:23 INFO - Running setup.py (path:/tmp/pip-0TF7k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:23 INFO - Running setup.py (path:/tmp/pip-H0AOTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:23 INFO - Running setup.py (path:/tmp/pip-clLRU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:23 INFO - Running setup.py (path:/tmp/pip-dWBYxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:23 INFO - Running setup.py (path:/tmp/pip-fVtiwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:23 INFO - Running setup.py (path:/tmp/pip-tZa_tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:23 INFO - Running setup.py (path:/tmp/pip-_nGQEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44: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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:24 INFO - Running setup.py (path:/tmp/pip-JnMTsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44: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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:24 INFO - Running setup.py (path:/tmp/pip-VkDjVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44: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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:24 INFO - Running setup.py (path:/tmp/pip-z6N4MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44: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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:24 INFO - Running setup.py (path:/tmp/pip-_7BttA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:26 INFO - Downloading blessings-1.6.tar.gz 07:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:26 INFO - Installing collected packages: blessings 07:44:26 INFO - Running setup.py install for blessings 07:44:26 INFO - Successfully installed blessings 07:44:26 INFO - Cleaning up... 07:44:26 INFO - Return code: 0 07:44:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:26 INFO - Reading from file tmpfile_stdout 07:44:26 INFO - Current package versions: 07:44:26 INFO - argparse == 1.2.1 07:44:26 INFO - blessings == 1.6 07:44:26 INFO - blobuploader == 1.2.4 07:44:26 INFO - docopt == 0.6.1 07:44:26 INFO - functools32 == 3.2.3-2 07:44:26 INFO - jsonschema == 2.5.1 07:44:26 INFO - manifestparser == 1.1 07:44:26 INFO - mozInstall == 1.12 07:44:26 INFO - mozcrash == 0.17 07:44:26 INFO - mozdebug == 0.1 07:44:26 INFO - mozdevice == 0.48 07:44:26 INFO - mozfile == 1.2 07:44:26 INFO - mozhttpd == 0.7 07:44:26 INFO - mozinfo == 0.9 07:44:26 INFO - mozleak == 0.1 07:44:26 INFO - mozlog == 3.2 07:44:26 INFO - moznetwork == 0.27 07:44:26 INFO - mozprocess == 0.22 07:44:26 INFO - mozprofile == 0.28 07:44:26 INFO - mozrunner == 6.11 07:44:26 INFO - mozscreenshot == 0.1 07:44:26 INFO - mozsystemmonitor == 0.3 07:44:26 INFO - moztest == 0.7 07:44:26 INFO - mozversion == 1.4 07:44:26 INFO - psutil == 3.1.1 07:44:26 INFO - requests == 1.2.3 07:44:26 INFO - wsgiref == 0.1.2 07:44:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:44:26 INFO - Using env: {'DISPLAY': ':0', 07:44:26 INFO - 'HOME': '/home/cltbld', 07:44:26 INFO - 'LANG': 'en_US.UTF-8', 07:44:26 INFO - 'LANGUAGE': 'en_US:en', 07:44:26 INFO - 'LOGNAME': 'cltbld', 07:44:26 INFO - 'MAIL': '/var/mail/cltbld', 07:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:26 INFO - 'MOZ_NO_REMOTE': '1', 07:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:26 INFO - 'NO_EM_RESTART': '1', 07:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:26 INFO - 'PWD': '/builds/slave/test', 07:44:26 INFO - 'SHELL': '/bin/bash', 07:44:26 INFO - 'SHLVL': '1', 07:44:26 INFO - 'TERM': 'linux', 07:44:26 INFO - 'TMOUT': '86400', 07:44:26 INFO - 'USER': 'cltbld', 07:44:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:26 INFO - '_': '/tools/buildbot/bin/python'} 07:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:44:26 INFO - Cleaning up... 07:44:26 INFO - Return code: 0 07:44:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:44:26 INFO - Using env: {'DISPLAY': ':0', 07:44:26 INFO - 'HOME': '/home/cltbld', 07:44:26 INFO - 'LANG': 'en_US.UTF-8', 07:44:26 INFO - 'LANGUAGE': 'en_US:en', 07:44:26 INFO - 'LOGNAME': 'cltbld', 07:44:26 INFO - 'MAIL': '/var/mail/cltbld', 07:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:26 INFO - 'MOZ_NO_REMOTE': '1', 07:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:26 INFO - 'NO_EM_RESTART': '1', 07:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:26 INFO - 'PWD': '/builds/slave/test', 07:44:26 INFO - 'SHELL': '/bin/bash', 07:44:26 INFO - 'SHLVL': '1', 07:44:26 INFO - 'TERM': 'linux', 07:44:26 INFO - 'TMOUT': '86400', 07:44:26 INFO - 'USER': 'cltbld', 07:44:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:26 INFO - '_': '/tools/buildbot/bin/python'} 07:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:44:27 INFO - Cleaning up... 07:44:27 INFO - Return code: 0 07:44:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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 0x7fbb506f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', '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 07:44: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 07:44: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 07:44:27 INFO - Using env: {'DISPLAY': ':0', 07:44:27 INFO - 'HOME': '/home/cltbld', 07:44:27 INFO - 'LANG': 'en_US.UTF-8', 07:44:27 INFO - 'LANGUAGE': 'en_US:en', 07:44:27 INFO - 'LOGNAME': 'cltbld', 07:44:27 INFO - 'MAIL': '/var/mail/cltbld', 07:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:27 INFO - 'MOZ_NO_REMOTE': '1', 07:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:27 INFO - 'NO_EM_RESTART': '1', 07:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:27 INFO - 'PWD': '/builds/slave/test', 07:44:27 INFO - 'SHELL': '/bin/bash', 07:44:27 INFO - 'SHLVL': '1', 07:44:27 INFO - 'TERM': 'linux', 07:44:27 INFO - 'TMOUT': '86400', 07:44:27 INFO - 'USER': 'cltbld', 07:44:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:27 INFO - '_': '/tools/buildbot/bin/python'} 07:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:27 INFO - Downloading/unpacking flake8 07:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:44:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:44:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:29 INFO - no previously-included directories found matching 'docs/_build' 07:44:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:44:29 INFO - Running setup.py install for pep8 07:44:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:30 INFO - no previously-included directories found matching 'docs/_build' 07:44:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:44:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:44:30 INFO - Cleaning up... 07:44:30 INFO - Return code: 0 07:44:30 INFO - Running post-action listener: _resource_record_post_action 07:44:30 INFO - Running post-action listener: _start_resource_monitoring 07:44:30 INFO - Starting resource monitoring. 07:44:30 INFO - ##### 07:44:30 INFO - ##### Finished create-virtualenv step (success) 07:44:30 INFO - ##### 07:44:30 INFO - ##### 07:44:30 INFO - ##### Running install step. 07:44:30 INFO - ##### 07:44:30 INFO - Running pre-action listener: _resource_record_pre_action 07:44:30 INFO - Running main action method: install 07:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:30 INFO - Reading from file tmpfile_stdout 07:44:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:30 INFO - Reading from file tmpfile_stdout 07:44:30 INFO - Output received: 07:44:30 INFO - Usage: mozinstall [options] installer 07:44:30 INFO - Options: 07:44:30 INFO - -h, --help show this help message and exit 07:44:30 INFO - -d DEST, --destination=DEST 07:44:30 INFO - Directory to install application into. [default: 07:44:30 INFO - "/builds/slave/test"] 07:44:30 INFO - --app=APP Application being installed. [default: firefox] 07:44:30 INFO - mkdir: /builds/slave/test/build/application 07:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:44:46 INFO - Reading from file tmpfile_stdout 07:44:46 INFO - Output received: 07:44:46 INFO - /builds/slave/test/build/application/firefox/firefox 07:44:46 INFO - Running post-action listener: _resource_record_post_action 07:44:46 INFO - ##### 07:44:46 INFO - ##### Finished install step (success) 07:44:46 INFO - ##### 07:44:46 INFO - ##### 07:44:46 INFO - ##### Running run-tests step. 07:44:46 INFO - ##### 07:44:46 INFO - Running pre-action listener: _resource_record_pre_action 07:44:46 INFO - Running main action method: run_tests 07:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:46 INFO - Python 2.7.3 07:44:46 INFO - Return code: 0 07:44:46 INFO - grabbing minidump binary from tooltool 07:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21bc1c0>, '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 0x21bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bd550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:44:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:44:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:44:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:46 INFO - Return code: 0 07:44:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:44:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:44:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:44:47 INFO - Return code: 0 07:44:47 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/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:44:47 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/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 07:44:47 INFO - Using env: {'DISPLAY': ':0', 07:44:47 INFO - 'HOME': '/home/cltbld', 07:44:47 INFO - 'LANG': 'en_US.UTF-8', 07:44:47 INFO - 'LANGUAGE': 'en_US:en', 07:44:47 INFO - 'LOGNAME': 'cltbld', 07:44:47 INFO - 'MAIL': '/var/mail/cltbld', 07:44:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:47 INFO - 'MOZ_NO_REMOTE': '1', 07:44:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:47 INFO - 'NO_EM_RESTART': '1', 07:44:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:47 INFO - 'PWD': '/builds/slave/test', 07:44:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:47 INFO - 'SHELL': '/bin/bash', 07:44:47 INFO - 'SHLVL': '1', 07:44:47 INFO - 'TERM': 'linux', 07:44:47 INFO - 'TMOUT': '86400', 07:44:47 INFO - 'USER': 'cltbld', 07:44:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544', 07:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:47 INFO - '_': '/tools/buildbot/bin/python'} 07:44:47 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/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:44:47 INFO - mozversion application_buildid: 20160627051226 07:44:47 INFO - mozversion application_changeset: 852f817ca2c4a23f0736c4407305341adbc99904 07:44:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:44:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:47 INFO - mozversion application_name: Firefox 07:44:47 INFO - mozversion application_remotingname: firefox-dev 07:44:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:44:47 INFO - mozversion application_vendor: Mozilla 07:44:47 INFO - mozversion application_version: 49.0a2 07:44:47 INFO - mozversion platform_buildid: 20160627051226 07:44:47 INFO - mozversion platform_changeset: 852f817ca2c4a23f0736c4407305341adbc99904 07:44:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:44:47 INFO - mozversion platform_version: 49.0a2 07:44:47 INFO - using testdate: 1467038687 07:44:47 INFO - actual date: 1467038687 07:44:47 INFO - starting webserver on 'localhost:49036' 07:44:47 INFO - SUITE-START | Running 2 tests 07:44:47 INFO - TEST-START | dromaeo_css 07:44:47 INFO - operating with platform_type : linux_ 07:44:47 INFO - Initialising browser for dromaeo_css test... 07:44:47 INFO - TEST-INFO | started process 24273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl70Ra7/profile http://localhost:49036/getInfo.html) 07:44:51 INFO - PROCESS | 24273 | __metrics Screen width/height:1600/1200 07:44:51 INFO - PROCESS | 24273 | colorDepth:24 07:44:51 INFO - PROCESS | 24273 | Browser inner width/height: 1024/697 07:44:51 INFO - PROCESS | 24273 | __metrics 07:44:52 ERROR - PROCESS | 24273 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:44:53 INFO - PROCESS | 24273 | console.error: PushService: 07:44:53 INFO - PROCESS | 24273 | stateChangeProcessEnqueue: Error transitioning state 07:44:53 INFO - PROCESS | 24273 | UnknownError 07:44:53 INFO - TEST-INFO | 24273: exit 0 07:44:53 INFO - Browser initialized. 07:44:53 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:53 INFO - TEST-INFO | started process 24364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl70Ra7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:05 INFO - PROCESS | 24364 | RSS: Main: 145448960 07:45:05 INFO - PROCESS | 24364 | 07:45:56 INFO - PROCESS | 24364 | 1467038756814 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] 07:48:04 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:49036/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49036/tests/dromaeo/cssquery-ext.html) 07:48:05 INFO - PROCESS | 24364 | RSS: Main: 256143360 07:48:05 INFO - PROCESS | 24364 | 07:51:08 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:49036/tests/dromaeo/cssquery-ext.html (next: http://localhost:49036/tests/dromaeo/cssquery-jquery.html) 07:51:08 INFO - PROCESS | 24364 | RSS: Main: 232607744 07:51:08 INFO - PROCESS | 24364 | 07:54:10 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:49036/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49036/tests/dromaeo/cssquery-mootools.html) 07:54:11 INFO - PROCESS | 24364 | RSS: Main: 228524032 07:54:11 INFO - PROCESS | 24364 | 07:57:13 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:49036/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49036/tests/dromaeo/cssquery-prototype.html) 07:57:14 INFO - PROCESS | 24364 | RSS: Main: 220737536 07:57:14 INFO - PROCESS | 24364 | 08:00:16 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:49036/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49036/tests/dromaeo/cssquery-yui.html) 08:00:17 INFO - PROCESS | 24364 | RSS: Main: 214982656 08:00:17 INFO - PROCESS | 24364 | 08:03:19 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:49036/tests/dromaeo/cssquery-yui.html (next: http://localhost:49036/tests/dromaeo/cssquery-dojo.html) 08:03:20 INFO - PROCESS | 24364 | RSS: Main: 261754880 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | __start_tp_report 08:03:20 INFO - PROCESS | 24364 | _x_x_mozilla_page_load 08:03:20 INFO - PROCESS | 24364 | _x_x_mozilla_page_load_details 08:03:20 INFO - PROCESS | 24364 | |i|pagename|runs| 08:03:20 INFO - PROCESS | 24364 | |0;dojo.html;3413.453847384418;3431.502432147339;3442.053435305291;3463.774854634447;3482.860685572577;5648.943510564893;5730.341010783761;5740.5981581289325;5755.0504166812425;5757.136429535566;5635.6618602883855;5723;5728.513076388502;5728.570357223204;5733.684647344395;4981.5516603505675;5078.771455284521;5154.974225128888;5182.766775495093;5218.139007063849;5038.470960549144;5128.410232823236;5173.534381905628;5176.974115129438;5189.558887494568;5139.25480805283;5179.533841954223;5192.506711862367;5211.661242019276;5232.73836308183;5276.050310944029;5290.55030322423;5295.258663787073;5298.867528311785;5328.6802791832615;4989.326440930464;5118.718470484122;5152.484751524855;5176.197689358156;5188.273641690166;5485.478879506481;5485.61600687952;5522.420145884705;5524.088525393306;5544.306961629796;6066.792477257004;6079.659356019725;6079.726412311456;6091.664958427285;6096.939030609681;5999.730012149464;6061.333253342129;6076.817695469143;6084.5132389408745;6086.150718919058;5636.830895073154;5692.231548740909;5698.059820129673;5698.487136157724;5706.3152421709665;5980.162777211194;6113.877722445526;6120.540959427972;6133.101782541855;6134.2332208473945;5897.616654917417;5915.940840591625;5938.673372964442;6035.818925432244;6059.7273122709585;6072.635641861502;6086.904357215743;6089.543284253698;6090.116933044684;6111.877762444815;5842.298924129132;5937.287525496968;6067.726952287069;6070.544709146831;6075.939240607626;5957.553183511254;5983.700814959235;6014.308354539196;6015.398460154037;6059.121427393004;4571.245744452128;4589.059242855206;4602.930956035662;4609.216433206363;4612.262038073892;4031.0930040741187;4061.6750659947133;4097.13960068383;4118.361653943643;4131.876043718693;5741.167530708108;5745.368009518949;5765.654060756284;5768.394318596571;5796.652200867961;6036.215292012098;6086.482648974887;6093.969530152321;6096.963516202256;6128.448439640454;5527.309086364205;5722.799702010409;5752.9712351437975;5766.94233057664;5782.768689252467;5241.475852414805;5241.68549887008;5244.108501554745;5251.553617942518;5258.106121959276;6347.460465860361;6353.872922541524;6356.300806911328;6362.618242905441;6367.076773867856;5954.553408494294;6017.338092809875;6062.848428789315;6064.969675151596;6131.294901086254;6298.937010630018;6308.179936608211;6336.524760642878;6358.300586935526;6359.49124070064;5751.626144300774;6016.639001659914;6031.668258245839;6047.727852246748;6052.878942421215;5979.730912108878;5999.760009599741;6031.668258245839;6079;6101.633901965896;5863.882722345615;5911.467967882912;5912.408759124053;5915.733791979457;5922.378150294157;5705.058665320175;5839;5890.734916928663;5893.469587737124;5933.050711886078;5739.713014349182;5743.942560574341;5802.82591522255;5827.4172582741385;5849.093390524476;5858.297004359334;5863.94136058651;6002.8499287516415;6010.729517171825;6014.849628759316;5647.0964645656495;5763.106718458645;5841.386654401226;5842.357340692605;5863.325717542537 08:03:20 INFO - PROCESS | 24364 | |1;ext.html;612.6722203621064;656.671664167916;658.578509753758;670.4301343857721;670.7819958513481;31919.52120718191;34413.65586344139;44763.10473790526;45868.311975320394;46006;47880.521194788045;48168.51831481684;48266.27600585985;48321.51678483214;48361.758191208995;9120.361574689758;9205.079492050809;9211.078892110801;9270.07299270071;9281.535923203846;8370.916290837074;10754.623588174416;10908;10961;11205.719857003558;11003.669889903276;11081.113510919107;11090.889091109108;11098.223124381297;11101.72245693856;8284.378671599654;8486.27866631337;10841.620543280987;10891.128709703205;10914.617988370448;8625.870611940825;10672.146228301717;10973;11012.944935275353;11024.779504409948;41468.37797433041;41757.58242417567;41920.95197620054;45956.08087838224;45975.770121149515;3764.3036038333;3801.3347664158937;4024.4566983457153;4177.916441671149;4355.912881742347;35298.11754706153;35639;35792.64207357945;35818;35825.28349433023;4687.414073240845;4785.760711964388;4805.087033463631;4828.082664293773;4829.830955916526;358190;358648;360304;360626;360907;69123.65438172777;69546.65226673834;69652.651736741;69705.3029469709;69730.30269697339;40653;41617.1676566467;41695.374569381485;43646;43685.78157109194;17674.5581360467;17787.822121778616;17952;17957.102144892702;17958.19188136537;12206.206596571194;12590.622281331574;12795.808062879065;12925.28910909909;13183.802242966363;22444;22482.32553023412;22511.549769004527;22536.436589085075;22622.547549048926;8130.674773009132;8194.631241594143;8372.874406883902;8394.496330220207;8567.4002819802;1086.375334182848;1146.037328643943;1175.024729474534;1204.1390405859852;1293.3016171267598;32999.50500742491;34630.653693462744;34644.307113858085;34913.12717182091;35066;1173.9823902641467;1253.529926277646;1283.050542598489;1292.095533126815;1314.3428285857071;18327.450176494727;18392.26430942747;18476.168572414274;18512.722309165372;18565.35021274249;532627;535504;535935;536822;538130;63578.682106590095;64957;64985.35014649887;64993.350066499675;65203;1371.1704418826466;1465.5603319004256;1498.423107103773;1517.9848201517843;1538.5076775431978;33698.326033478705;35125.64874351224;35289.29421411506;35829.46255806217;36050;56128.71935640459;56794.716026419606;56936.71531642315;56977.71511142418;57041.71479142744;396118;405210;405264;405424;406061;28195.43609127847;30495.237619059702;31028.22429439282;31606.525902111945;33115.17212069718;50828.74585627196;51328.74335628298;51338;52019.73990130025;52579.21131182959;42811.357829633205;42982.78508607437;43225.3516197251;43574.782126089165;44455.55544444514;43757.78121109374;43792.56207438013;44495.777521112184;48019.51980480151;48405.75797120992;45888.77055614834;46477.767611161726;46772;47027.52972470369;47157.764211180096;37968;39928.60071399249;40082.59917400789;40257.79871100626;40394.192116156926;30306.393872121993;30721.846390767903;30733.53899691551;30834.845825770728;30858.69141308558 08:03:20 INFO - PROCESS | 24364 | |2;jquery.html;414.55228353378345;425.4639154665121;427.2224551316604;429.15456550595314;443.27745774387745;18732.34436794711;19901.800981990193;20744.066517006733;21046.158153673834;21088;18298.725519117223;19352.70970935437;19372.61254774907;19389.12748926298;19929.800701992976;5257.86855328617;5361.276227709248;5402.621816472849;5414.972925135388;5417.431169727181;3955.7033222508426;4449.977750111261;5292.2061690746505;5335.919961200585;6387.808365749035;6624.105745724314;6638.767643132492;6671.633060181688;6678.365555272266;6682.599044057348;6453.290138084807;6514.44627206688;6616.569922954993;6634.635095069769;6644.568103073285;3873.57390687027;5915.260592425947;5925.644461332334;6585.2097748270035;7236.529625574321;25266.621000685005;26239.475210495875;26763;27916.16251512458;27923.162305130878;2534.4804315115357;2642.828216165943;2659.5611724065507;2663.227663977444;2690.9327266818486;15565.29956151976;15790.684186316324;15870.682586348208;16748;17043.57391065221;1880.4264699266719;1993.8105879941381;2016.8285695715736;2058.742657167854;2079.8440116991287;65174;69752;89050;89374.5531272346;97169;9010.549472526347;9791.265655075898;9808.852867206855;10442.895571044344;10494.055535001886;14117.223552704494;14223.146611203361;14251.857481425053;14319.713605728035;14344.067635603653;7840.882386764203;8116.107228204893;8202.794930126794;8310.584470776437;8333.791655208668;7957.482763620346;8081.838363232702;8118.553479558563;8145.79635509117;8299.128591497927;4335.393044973706;4351.564843515623;4364.956350436455;4423.049044455457;4441.71128876622;1941.8640695151487;1997.3508609701905;2010.7587089549056;2039.5614942787372;2044.8159665630164;448.8889997256829;495.91817350137546;983.8130755156498;1054.9081700440008;1067.5516283161091;11139.944300278446;11937.820932686016;11986.460609272604;12015.939920300343;12114;489.85059556835506;500.47200203784627;509.8572399728082;519.5038738005196;534.188034188032;6481.837954051187;6514.478841692748;6531.987541931008;6540.771073012517;6615.569987950767;459438;468315;468509;469754;478314;58120.999999999156;92513.53743231241;96268;98584.50707746415;98607;458.4796256249181;506.05115408608856;520.786477544205;521.0854949563492;522.4514260026956;9117.635294588408;10850.240483166102;10914.454277286262;11631.185816992729;11648.94175529117;41134.38298425466;41831.58168418277;42263.15473690447;42832.57167428286;42932.78533607312;58770;58988;59142.70428647829;60754.39245607664;60974.08538871832;7499.175090740124;7698.230176982257;8030.23712747288;8196.918030819616;8277;9690.612375504901;13784.517541885985;13881.930590346983;13946.930265348608;14240.572782816533;11934.28394296345;12054.939725301318;12158.270503769802;12303.384830758605;12567.87432125667;11496.425178741198;11536.134789890624;11706.297622142698;11950.163488556065;11984;9027.638894444148;12122.939385303018;12140.514379424723;12708.618741437771;12778.361081946052;8246.670133194604;8399;8429.241368276884;8464.788380290542;8558.657653694032;11926.940365298118;12250.816237756619;12309.876901230873;12381.442835072263;12386.81419778686 08:03:20 INFO - PROCESS | 24364 | |3;mootools.html;1336.7927971164472;1571.5678188498157;1625.1955282135345;1857.702767557191;1970.9408717738472;9195.678151264707;9606.42361458313;9631.614735410583;9874.407535547873;9900.554475048622;9550.570224339905;9748.31761776676;9761.219102471803;9776.951115244432;9779.217662586994;2213.3359992002415;2455.9263222103364;2530.228280374485;2548.6941567011986;2570.408805974627;2567.1913347295636;2571.2800415883585;2576.291519832052;2577.6004719268544;2578.8968441262327;2454.2023842251338;2538.6318983747346;2538.669972903529;2540.9074098137794;2541.7712405883467;2144.3888491779844;2431.90272389106;2433.270018994295;2509.849409035464;2510.6736124303725;2492.887820048084;2500.1374525788574;2522;2526.759957804006;2539.3524651214007;9682.419054856731;9720.854187187198;9722.562484688135;9723.756906077333;9732.270079744048;5800.738966746464;5907.7046147692445;5940.2871655401195;5968.462838344526;5974;3538.610752817188;3609.530761001079;3655.3785856404475;3750.718696097804;3756.7182461315238;1188.0792385900909;1199.1306302930393;1227.1900545639924;1232.1559731583804;1273.3951373097798;14032.789508157386;14072.437102515887;14076.436942522389;14079.225642589654;14080.2959852008;5058.291839142523;5086.593072554187;5117.130087885069;5334.493223143795;5343.145096784496;11077.723056923642;11152.2751021185;11171.608993685182;11176.329420234812;11181.44092795357;5929.229200203946;5929.584929055011;5938.673372964528;5940.524758019348;5950.9702451487465;4832.758362081881;5316.973415132977;5483.890322193533;5499.257600223998;5577.832665020056;4261.659067274611;4299.634531064832;4321.7406955582765;4354.063876266618;4379.277419225856;1282.8652991435765;1305.2755720574983;1306.6537367597593;1319.5447570588133;1328.2760895312078;1075.8224892892742;1088.1675518228562;1094.584058057933;1099.340395762536;1100.9870918754764;6368.10846481493;6422.6467544285515;6448.838779030468;6502.869942601122;6580.322017885409;494.1771949703775;494.2882249560621;495.7100096443549;497.3385397421421;512.9230615407644;4454.977725111354;4470.485894122153;4511.8646440606835;4529.433820772403;4546.136234115507;12092.334921579397;12485.438155283035;12500.062495312888;12526.937365313297;12581.622551323475;11755.706107347214;12294.385280736105;12400.13199076056;12502.312372819582;12527.248365098123;8901.154390333037;9247.398919070374;9279.118483744034;9281.767955801024;9317.068293170765;6615.933840661532;6765.1205343305055;6810.9318906810295;6830.077939478107;6862.073620061228;11058.115350771757;11346.319220846775;11494.02300804441;11525.654230373102;11608.071354291467;11470.483828227916;11600.5359785611;11603.5358585659;11605.88394116048;11686.474108664961;7839.294463498312;8115.310198633182;8116.553589552395;8794.780130496789;9002.459852408876;8987.730368088967;9178.173964343241;9476.763080923032;9503.144716975505;9749.512524373895;8458;8713.91286087131;8749.08134645853;8798.824023519623;8878.73363799087;8318.70884519039;8356.749297521084;8490.108538603605;8513.489190648581;8552.743417697478;7983.321417679563;8033.19668033192;8073.959630201812;8083.353331733565;8083.8383232333845;5691.800786972436;5837.153612726216;5903.616264942765;5906.283406580361;5992.370801065826;5452.972735136299;5507.862303442446;5572.832815015556;5745.712714364348;5775.9133612995 08:03:20 INFO - PROCESS | 24364 | |4;prototype.html;334.8827910231419;342.6641890946872;350.20154048768813;350.5582965463516;354.6400403590355;5404.7838086476595;5532.529734972527;5542.087979647025;5608.971955140224;5647.209390685307;5522.475364840334;5542.251796007537;5556.13858862685;5567.6659400436;5575.665460072399;4345.8478953236645;4364.912701745963;4380.408644832939;4402.801873915665;4403.119376124771;4240.830366785325;4320.82716691332;4351.760653164075;4363.716358436692;4389.341598760179;4269.935950960738;4287.292596721537;4312;4318.287482565373;4320.416743739586;4293.377460268243;4295.763732994684;4342.935980684752;4343.283358245902;4368.410264614268;3773.8301776420126;3875.3411919973673;3876.980615096935;3881.961180388188;3895.6493915547735;5378.731063446812;5423.562755869698;5430.782768689248;5431.646942948696;5437.238786569844;5026.52248036436;5029.748512574357;5043.193089105762;5055.721935293557;5123.615728820316;5624.21261023457;5846.736896839652;5865.472107510344;5902.3507414184405;5904.232449781543;4232.87828725388;4272.359146128075;4276.893077673052;4289.463817022872;4321.286987647034;5980.8504787380225;6064.211652485193;6080.847978800522;6137.7851775187655;6139.815805525842;4370.694051416371;4380.627646650007;4385.122975404932;4390.792532053711;4402.317640765622;4384.232759267115;4384.824607015684;4399.076193999296;4432.401625780542;4434.423524941737;4813.518648135228;4994.250862370601;5021.573166280907;5025.246213068069;5025.497450254945;5568.164775283659;5851.297844258716;5851.356350801409;5854.385289544536;5864.618799778001;1468.3686015013434;1508.9924550377398;1510.735621266274;1520.1715065289443;1527.2821773766311;962.7352478068588;970.2432102959702;991.5884907763342;1001.8597396364515;1004.5278719002204;4986.351774269322;5008.974955125274;5011.774470148852;5015.921576860992;5020.196768517019;5257.894842103136;5258.553022993012;5294.205869119663;5308.973455132699;5319.867003324948;4953.578945789648;5007.324011258506;5055.230669265801;5234.377343023675;5673.858153546112;3188.3782662380613;3202.951955720666;3217.2761128746315;3220.62962759281;3241.6110066792135;6074.271087469444;6242.75028998844;6253.249610046823;6274.435300822856;6278.340774218733;6118.479929205978;6147.877042459215;6148.692565371803;6155.384461553809;6155.384461553898;6142.556499222679;6158.445739883432;6185.134081228722;6204.441600255998;6208.2373343861545;5840.824775256579;5928.170056192223;6005.789797357072;6031.306399764083;6046.879062418815;5891.410858914246;5893.675847828411;5919.2179675552425;5964.403559644001;5973.1338955852025;5970.164177015135;6151.015837465984;6192.318844927145;6218.9378106218355;6235.688215589294;4310.31035034393;4357.278874844482;4377;4381.269398587477;4399.956000439955;5757.280339957505;5921.259842519685;6017.518598512021;6130.969345153246;6138.846528836815;5844.240248767633;5846.707664616667;5848.561357898089;5868.474196708801;5888.528917686661;5802.259322203237;5828.6211396259105;5839.328477225174;5846.970765146317;5854.736536855767;5530.723463826712;5720.742566584597;5770.336411312753;5781.913271300849;5792.913106303325;5826.41735826414;5829.621074630136;5851.736671849862;5880.235569375954;5909.729408177091;5472.5348345391085;5682.5453963681975;5740.799072032459;5802.593818432669;5829.59192856513 08:03:20 INFO - PROCESS | 24364 | |5;yui.html;796.3788245168766;812.3176531713361;812.3825892321837;843.9915600843991;895.4537731983485;15822.208889555519;15887.285072171751;16025;17064.402745903895;17172.65654686907;15921;15988.280527376266;16186.676266474664;16196.676066478663;16222.7566586501;726.4442701333484;861.1388611388611;868.7133246028811;895.5701263393574;902.6975963052386;884.7788052986754;885.5041176940902;888.7778055486128;889.4752096263203;891.3849443883732;932.086555175928;934.4533447932934;934.5280633280217;934.607464864755;934.6681927915594;763.4465012865655;911.1344222988155;932.3986029011284;932.9626814927462;937.161240689579;687.089606271692;687.5015613680092;688.1295161620554;688.469878193788;689.5552368722147;15522.456714014956;15586.376544938188;15593.610159745984;15594.37622495099;15600.375984960701;15003.39881215234;15076.623084422867;15309.61725956849;15718.685626287524;15861.36554537817;12097.455614497281;12211;12212.023038156925;12372.81440778389;12450.25298482094;4098.631123198927;4816.54242846929;4889.3888263967;4952.158133117378;4953.331300274453;70515.29484705138;81198.9999999994;81207;81225.59387203085;81288.18711812866;12713.364331783374;13069.934650326877;13128.949684025256;13161.868381316064;13187.14283571584;24249.878750606134;24395.048396128266;24428.63357049646;24451.755482445304;24933;9405.20055795265;9439.622415103318;9442.291828112782;9525.190358819578;9660.275479339078;5070.366204224472;5148.639595228298;5197.896042079213;5307.177387504943;5313.335833020872;3971.602839716063;4056.6146216109423;4078.490188726409;4083.14254006656;4102.2410853992105;648.5330561995356;695.8051745511265;705.4955706669654;760.9543427394374;801.6592947997078;723.3706675192616;752.8005078654161;812.7033632724132;818.9190268845186;849.5794581682106;10413.42726150054;10480.213983951235;10497.422641754623;10594.682159535227;10633.89366106329;731.2322061835158;765.12775436003;800.491687778265;813.3493205435627;824.3858325547506;5429.728513574306;5544.805931792368;5687.317521897398;5699.430056994351;5798;124347;126375;127382;128761;133726;64074.35925640777;85966;109933;112022.43988780004;112523;94046;96030.51984740031;96731;101144;101908;10898.400587967737;10972;11221.55113795439;11231.66305010851;11355.602553910574;54296.728516357165;54985;55390.44609554014;55733.721331393084;56919.43080569307;62298;79809.60095199487;81288;82319.17680823115;85681;13947.511837085653;14109.365078571283;14801;14832.925835370754;15014.249287535798;15285.847141528442;15305.540833775005;15638.139902305482;15824.208789560706;16974.236159373104;14787.704245915236;14882.925585372004;15003.849961500246;15432.151231681915;15451.459198927983;14814.444783023413;14978.47575334858;15132.621684457976;15278.15970121654;15589.766153507933;14391.568252952427;14468.565943021305;14584.635384115481;15049.623759405664;15066.773998389814;12223.511059557519;12676.619701408972;12861.871381286068;12907.419166137359;12982.350882456029;12138.939305303416;12395.132340736423;12905.870941290843;13165.736685266433;13509.189448633113 08:03:20 INFO - PROCESS | 24364 | __end_tp_report 08:03:20 INFO - PROCESS | 24364 | __start_cc_report 08:03:20 INFO - PROCESS | 24364 | _x_x_mozilla_cycle_collect,884 08:03:20 INFO - PROCESS | 24364 | __end_cc_report 08:03:20 INFO - PROCESS | 24364 | __startTimestamp1467039800119__endTimestamp 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | ------- Summary: start ------- 08:03:20 INFO - PROCESS | 24364 | Number of tests: 6 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | [#0] dojo.html Cycles:165 Average:5630.51 Median:5827.42 stddev:623.45 (10.7%) stddev-sans-first:600.61 08:03:20 INFO - PROCESS | 24364 | Values: 3413.5 3431.5 3442.1 3463.8 3482.9 5648.9 5730.3 5740.6 5755.1 5757.1 5635.7 5723.0 5728.5 5728.6 5733.7 4981.6 5078.8 5155.0 5182.8 5218.1 5038.5 5128.4 5173.5 5177.0 5189.6 5139.3 5179.5 5192.5 5211.7 5232.7 5276.1 5290.6 5295.3 5298.9 5328.7 4989.3 5118.7 5152.5 5176.2 5188.3 5485.5 5485.6 5522.4 5524.1 5544.3 6066.8 6079.7 6079.7 6091.7 6096.9 5999.7 6061.3 6076.8 6084.5 6086.2 5636.8 5692.2 5698.1 5698.5 5706.3 5980.2 6113.9 6120.5 6133.1 6134.2 5897.6 5915.9 5938.7 6035.8 6059.7 6072.6 6086.9 6089.5 6090.1 6111.9 5842.3 5937.3 6067.7 6070.5 6075.9 5957.6 5983.7 6014.3 6015.4 6059.1 4571.2 4589.1 4602.9 4609.2 4612.3 4031.1 4061.7 4097.1 4118.4 4131.9 5741.2 5745.4 5765.7 5768.4 5796.7 6036.2 6086.5 6094.0 6097.0 6128.4 5527.3 5722.8 5753.0 5766.9 5782.8 5241.5 5241.7 5244.1 5251.6 5258.1 6347.5 6353.9 6356.3 6362.6 6367.1 5954.6 6017.3 6062.8 6065.0 6131.3 6298.9 6308.2 6336.5 6358.3 6359.5 5751.6 6016.6 6031.7 6047.7 6052.9 5979.7 5999.8 6031.7 6079.0 6101.6 5863.9 5911.5 5912.4 5915.7 5922.4 5705.1 5839.0 5890.7 5893.5 5933.1 5739.7 5743.9 5802.8 5827.4 5849.1 5858.3 5863.9 6002.8 6010.7 6014.8 5647.1 5763.1 5841.4 5842.4 5863.3 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | [#1] ext.html Cycles:180 Average:61196.96 Median:40326.00 stddev:116093.63 (287.9%) stddev-sans-first:116330.19 08:03:20 INFO - PROCESS | 24364 | Values: 612.7 656.7 658.6 670.4 670.8 31919.5 34413.7 44763.1 45868.3 46006.0 47880.5 48168.5 48266.3 48321.5 48361.8 9120.4 9205.1 9211.1 9270.1 9281.5 8370.9 10754.6 10908.0 10961.0 11205.7 11003.7 11081.1 11090.9 11098.2 11101.7 8284.4 8486.3 10841.6 10891.1 10914.6 8625.9 10672.1 10973.0 11012.9 11024.8 41468.4 41757.6 41921.0 45956.1 45975.8 3764.3 3801.3 4024.5 4177.9 4355.9 35298.1 35639.0 35792.6 35818.0 35825.3 4687.4 4785.8 4805.1 4828.1 4829.8 358190.0 358648.0 360304.0 360626.0 360907.0 69123.7 69546.7 69652.7 69705.3 69730.3 40653.0 41617.2 41695.4 43646.0 43685.8 17674.6 17787.8 17952.0 17957.1 17958.2 12206.2 12590.6 12795.8 12925.3 13183.8 22444.0 22482.3 22511.5 22536.4 22622.5 8130.7 8194.6 8372.9 8394.5 8567.4 1086.4 1146.0 1175.0 1204.1 1293.3 32999.5 34630.7 34644.3 34913.1 35066.0 1174.0 1253.5 1283.1 1292.1 1314.3 18327.5 18392.3 18476.2 18512.7 18565.4 532627.0 535504.0 535935.0 536822.0 538130.0 63578.7 64957.0 64985.4 64993.4 65203.0 1371.2 1465.6 1498.4 1518.0 1538.5 33698.3 35125.6 35289.3 35829.5 36050.0 56128.7 56794.7 56936.7 56977.7 57041.7 396118.0 405210.0 405264.0 405424.0 406061.0 28195.4 30495.2 31028.2 31606.5 33115.2 50828.7 51328.7 51338.0 52019.7 52579.2 42811.4 42982.8 43225.4 43574.8 44455.6 43757.8 43792.6 44495.8 48019.5 48405.8 45888.8 46477.8 46772.0 47027.5 47157.8 37968.0 39928.6 40082.6 40257.8 40394.2 30306.4 30721.8 30733.5 30834.8 30858.7 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | [#2] jquery.html Cycles:180 Average:28173.82 Median:2433.16 stddev:77544.84 (3187.0%) stddev-sans-first:77734.36 08:03:20 INFO - PROCESS | 24364 | Values: 414.6 425.5 427.2 429.2 443.3 18732.3 19901.8 20744.1 21046.2 21088.0 18298.7 19352.7 19372.6 19389.1 19929.8 5257.9 5361.3 5402.6 5415.0 5417.4 3955.7 4450.0 5292.2 5335.9 6387.8 6624.1 6638.8 6671.6 6678.4 6682.6 6453.3 6514.4 6616.6 6634.6 6644.6 3873.6 5915.3 5925.6 6585.2 7236.5 25266.6 26239.5 26763.0 27916.2 27923.2 2534.5 2642.8 2659.6 2663.2 2690.9 15565.3 15790.7 15870.7 16748.0 17043.6 1880.4 1993.8 2016.8 2058.7 2079.8 65174.0 69752.0 89050.0 89374.6 97169.0 9010.5 9791.3 9808.9 10442.9 10494.1 14117.2 14223.1 14251.9 14319.7 14344.1 7840.9 8116.1 8202.8 8310.6 8333.8 7957.5 8081.8 8118.6 8145.8 8299.1 4335.4 4351.6 4365.0 4423.0 4441.7 1941.9 1997.4 2010.8 2039.6 2044.8 448.9 495.9 983.8 1054.9 1067.6 11139.9 11937.8 11986.5 12015.9 12114.0 489.9 500.5 509.9 519.5 534.2 6481.8 6514.5 6532.0 6540.8 6615.6 459438.0 468315.0 468509.0 469754.0 478314.0 58121.0 92513.5 96268.0 98584.5 98607.0 458.5 506.1 520.8 521.1 522.5 9117.6 10850.2 10914.5 11631.2 11648.9 41134.4 41831.6 42263.2 42832.6 42932.8 58770.0 58988.0 59142.7 60754.4 60974.1 7499.2 7698.2 8030.2 8196.9 8277.0 9690.6 13784.5 13881.9 13946.9 14240.6 11934.3 12054.9 12158.3 12303.4 12567.9 11496.4 11536.1 11706.3 11950.2 11984.0 9027.6 12122.9 12140.5 12708.6 12778.4 8246.7 8399.0 8429.2 8464.8 8558.7 11926.9 12250.8 12309.9 12381.4 12386.8 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | [#3] mootools.html Cycles:180 Average:6446.71 Median:2663.47 stddev:3754.24 (141.0%) stddev-sans-first:3745.12 08:03:20 INFO - PROCESS | 24364 | Values: 1336.8 1571.6 1625.2 1857.7 1970.9 9195.7 9606.4 9631.6 9874.4 9900.6 9550.6 9748.3 9761.2 9777.0 9779.2 2213.3 2455.9 2530.2 2548.7 2570.4 2567.2 2571.3 2576.3 2577.6 2578.9 2454.2 2538.6 2538.7 2540.9 2541.8 2144.4 2431.9 2433.3 2509.8 2510.7 2492.9 2500.1 2522.0 2526.8 2539.4 9682.4 9720.9 9722.6 9723.8 9732.3 5800.7 5907.7 5940.3 5968.5 5974.0 3538.6 3609.5 3655.4 3750.7 3756.7 1188.1 1199.1 1227.2 1232.2 1273.4 14032.8 14072.4 14076.4 14079.2 14080.3 5058.3 5086.6 5117.1 5334.5 5343.1 11077.7 11152.3 11171.6 11176.3 11181.4 5929.2 5929.6 5938.7 5940.5 5951.0 4832.8 5317.0 5483.9 5499.3 5577.8 4261.7 4299.6 4321.7 4354.1 4379.3 1282.9 1305.3 1306.7 1319.5 1328.3 1075.8 1088.2 1094.6 1099.3 1101.0 6368.1 6422.6 6448.8 6502.9 6580.3 494.2 494.3 495.7 497.3 512.9 4455.0 4470.5 4511.9 4529.4 4546.1 12092.3 12485.4 12500.1 12526.9 12581.6 11755.7 12294.4 12400.1 12502.3 12527.2 8901.2 9247.4 9279.1 9281.8 9317.1 6615.9 6765.1 6810.9 6830.1 6862.1 11058.1 11346.3 11494.0 11525.7 11608.1 11470.5 11600.5 11603.5 11605.9 11686.5 7839.3 8115.3 8116.6 8794.8 9002.5 8987.7 9178.2 9476.8 9503.1 9749.5 8458.0 8713.9 8749.1 8798.8 8878.7 8318.7 8356.7 8490.1 8513.5 8552.7 7983.3 8033.2 8074.0 8083.4 8083.8 5691.8 5837.2 5903.6 5906.3 5992.4 5453.0 5507.9 5572.8 5745.7 5775.9 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | [#4] prototype.html Cycles:180 Average:4889.13 Median:5434.44 stddev:1423.36 (26.2%) stddev-sans-first:1385.70 08:03:20 INFO - PROCESS | 24364 | Values: 334.9 342.7 350.2 350.6 354.6 5404.8 5532.5 5542.1 5609.0 5647.2 5522.5 5542.3 5556.1 5567.7 5575.7 4345.8 4364.9 4380.4 4402.8 4403.1 4240.8 4320.8 4351.8 4363.7 4389.3 4269.9 4287.3 4312.0 4318.3 4320.4 4293.4 4295.8 4342.9 4343.3 4368.4 3773.8 3875.3 3877.0 3882.0 3895.6 5378.7 5423.6 5430.8 5431.6 5437.2 5026.5 5029.7 5043.2 5055.7 5123.6 5624.2 5846.7 5865.5 5902.4 5904.2 4232.9 4272.4 4276.9 4289.5 4321.3 5980.9 6064.2 6080.8 6137.8 6139.8 4370.7 4380.6 4385.1 4390.8 4402.3 4384.2 4384.8 4399.1 4432.4 4434.4 4813.5 4994.3 5021.6 5025.2 5025.5 5568.2 5851.3 5851.4 5854.4 5864.6 1468.4 1509.0 1510.7 1520.2 1527.3 962.7 970.2 991.6 1001.9 1004.5 4986.4 5009.0 5011.8 5015.9 5020.2 5257.9 5258.6 5294.2 5309.0 5319.9 4953.6 5007.3 5055.2 5234.4 5673.9 3188.4 3203.0 3217.3 3220.6 3241.6 6074.3 6242.8 6253.2 6274.4 6278.3 6118.5 6147.9 6148.7 6155.4 6155.4 6142.6 6158.4 6185.1 6204.4 6208.2 5840.8 5928.2 6005.8 6031.3 6046.9 5891.4 5893.7 5919.2 5964.4 5973.1 5970.2 6151.0 6192.3 6218.9 6235.7 4310.3 4357.3 4377.0 4381.3 4400.0 5757.3 5921.3 6017.5 6131.0 6138.8 5844.2 5846.7 5848.6 5868.5 5888.5 5802.3 5828.6 5839.3 5847.0 5854.7 5530.7 5720.7 5770.3 5781.9 5792.9 5826.4 5829.6 5851.7 5880.2 5909.7 5472.5 5682.5 5740.8 5802.6 5829.6 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - PROCESS | 24364 | [#5] yui.html Cycles:180 Average:22449.29 Median:4014.11 stddev:32154.62 (801.0%) stddev-sans-first:32203.72 08:03:20 INFO - PROCESS | 24364 | Values: 796.4 812.3 812.4 844.0 895.5 15822.2 15887.3 16025.0 17064.4 17172.7 15921.0 15988.3 16186.7 16196.7 16222.8 726.4 861.1 868.7 895.6 902.7 884.8 885.5 888.8 889.5 891.4 932.1 934.5 934.5 934.6 934.7 763.4 911.1 932.4 933.0 937.2 687.1 687.5 688.1 688.5 689.6 15522.5 15586.4 15593.6 15594.4 15600.4 15003.4 15076.6 15309.6 15718.7 15861.4 12097.5 12211.0 12212.0 12372.8 12450.3 4098.6 4816.5 4889.4 4952.2 4953.3 70515.3 81199.0 81207.0 81225.6 81288.2 12713.4 13069.9 13128.9 13161.9 13187.1 24249.9 24395.0 24428.6 24451.8 24933.0 9405.2 9439.6 9442.3 9525.2 9660.3 5070.4 5148.6 5197.9 5307.2 5313.3 3971.6 4056.6 4078.5 4083.1 4102.2 648.5 695.8 705.5 761.0 801.7 723.4 752.8 812.7 818.9 849.6 10413.4 10480.2 10497.4 10594.7 10633.9 731.2 765.1 800.5 813.3 824.4 5429.7 5544.8 5687.3 5699.4 5798.0 124347.0 126375.0 127382.0 128761.0 133726.0 64074.4 85966.0 109933.0 112022.4 112523.0 94046.0 96030.5 96731.0 101144.0 101908.0 10898.4 10972.0 11221.6 11231.7 11355.6 54296.7 54985.0 55390.4 55733.7 56919.4 62298.0 79809.6 81288.0 82319.2 85681.0 13947.5 14109.4 14801.0 14832.9 15014.2 15285.8 15305.5 15638.1 15824.2 16974.2 14787.7 14882.9 15003.8 15432.2 15451.5 14814.4 14978.5 15132.6 15278.2 15589.8 14391.6 14468.6 14584.6 15049.6 15066.8 12223.5 12676.6 12861.9 12907.4 12982.4 12138.9 12395.1 12905.9 13165.7 13509.2 08:03:20 INFO - PROCESS | 24364 | -------- Summary: end -------- 08:03:20 INFO - PROCESS | 24364 | 08:03:20 INFO - TEST-INFO | 24364: exit 0 08:03:20 INFO - TEST-OK | dromaeo_css | took 1113212ms 08:03:20 INFO - TEST-START | kraken 08:03:20 INFO - operating with platform_type : linux_ 08:03:20 INFO - Initialising browser for kraken test... 08:03:20 INFO - TEST-INFO | started process 24554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC7O_lT/profile http://localhost:49036/getInfo.html) 08:03:24 INFO - PROCESS | 24554 | __metrics Screen width/height:1600/1200 08:03:24 INFO - PROCESS | 24554 | colorDepth:24 08:03:24 INFO - PROCESS | 24554 | Browser inner width/height: 1024/697 08:03:24 INFO - PROCESS | 24554 | __metrics 08:03:25 ERROR - PROCESS | 24554 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:03:25 INFO - PROCESS | 24554 | console.error: PushService: 08:03:25 INFO - PROCESS | 24554 | stateChangeProcessEnqueue: Error transitioning state 08:03:25 INFO - PROCESS | 24554 | UnknownError 08:03:26 INFO - TEST-INFO | 24554: exit 0 08:03:26 INFO - Browser initialized. 08:03:26 INFO - Running cycle 1/1 for kraken test... 08:03:26 INFO - TEST-INFO | started process 24643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC7O_lT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:38 INFO - PROCESS | 24643 | RSS: Main: 145588224 08:03:38 INFO - PROCESS | 24643 | 08:03:40 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49036/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:41 INFO - PROCESS | 24643 | RSS: Main: 194904064 08:03:41 INFO - PROCESS | 24643 | 08:03:44 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49036/tests/kraken/driver.html?testName=audio-dft) 08:03:44 INFO - PROCESS | 24643 | RSS: Main: 193282048 08:03:44 INFO - PROCESS | 24643 | 08:03:47 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49036/tests/kraken/driver.html?testName=audio-fft) 08:03:48 INFO - PROCESS | 24643 | RSS: Main: 278999040 08:03:48 INFO - PROCESS | 24643 | 08:03:50 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49036/tests/kraken/driver.html?testName=audio-oscillator) 08:03:50 INFO - PROCESS | 24643 | RSS: Main: 188387328 08:03:50 INFO - PROCESS | 24643 | 08:03:53 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49036/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:03:53 INFO - PROCESS | 24643 | RSS: Main: 188715008 08:03:53 INFO - PROCESS | 24643 | 08:03:56 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49036/tests/kraken/driver.html?testName=imaging-darkroom) 08:03:57 INFO - PROCESS | 24643 | RSS: Main: 223182848 08:03:57 INFO - PROCESS | 24643 | 08:04:00 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49036/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:01 INFO - PROCESS | 24643 | RSS: Main: 223428608 08:04:01 INFO - PROCESS | 24643 | 08:04:03 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49036/tests/kraken/driver.html?testName=json-parse-financial) 08:04:04 INFO - PROCESS | 24643 | RSS: Main: 223961088 08:04:04 INFO - PROCESS | 24643 | 08:04:06 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49036/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:06 INFO - PROCESS | 24643 | RSS: Main: 201461760 08:04:06 INFO - PROCESS | 24643 | 08:04:08 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:08 INFO - PROCESS | 24643 | RSS: Main: 202555392 08:04:08 INFO - PROCESS | 24643 | 08:04:10 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:11 INFO - PROCESS | 24643 | RSS: Main: 210456576 08:04:11 INFO - PROCESS | 24643 | 08:04:14 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:14 INFO - PROCESS | 24643 | RSS: Main: 214704128 08:04:14 INFO - PROCESS | 24643 | 08:04:17 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:04:17 INFO - PROCESS | 24643 | RSS: Main: 213843968 08:04:17 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | Cycle 1(1): loaded http://localhost:49036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49036/tests/kraken/driver.html?testName=ai-astar) 08:04:19 INFO - PROCESS | 24643 | RSS: Main: 255623168 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | __start_tp_report 08:04:19 INFO - PROCESS | 24643 | _x_x_mozilla_page_load 08:04:19 INFO - PROCESS | 24643 | _x_x_mozilla_page_load_details 08:04:19 INFO - PROCESS | 24643 | |i|pagename|runs| 08:04:19 INFO - PROCESS | 24643 | |0;ai-astar;110;105;110;111;109;108;111;109;109;110 08:04:19 INFO - PROCESS | 24643 | |1;audio-beat-detection;156;127;124;190;125;127;149;122;155;124 08:04:19 INFO - PROCESS | 24643 | |2;audio-dft;163;160;160;160;161;161;159;161;161;160 08:04:19 INFO - PROCESS | 24643 | |3;audio-fft;75;75;76;131;77;76;76;76;113;75 08:04:19 INFO - PROCESS | 24643 | |4;audio-oscillator;84;85;116;85;85;85;120;84;85;122 08:04:19 INFO - PROCESS | 24643 | |5;imaging-gaussian-blur;116;118;117;117;117;117;117;117;117;117 08:04:19 INFO - PROCESS | 24643 | |6;imaging-darkroom;147;146;145;146;148;145;145;145;146;145 08:04:19 INFO - PROCESS | 24643 | |7;imaging-desaturate;96;95;95;95;94;95;97;94;96;94 08:04:19 INFO - PROCESS | 24643 | |8;json-parse-financial;49;49;50;50;51;53;50;51;50;51 08:04:19 INFO - PROCESS | 24643 | |9;json-stringify-tinderbox;60;60;59;60;60;65;60;59;61;60 08:04:19 INFO - PROCESS | 24643 | |10;stanford-crypto-aes;75;76;76;82;77;77;81;82;107;76 08:04:19 INFO - PROCESS | 24643 | |11;stanford-crypto-ccm;122;118;125;120;118;124;123;117;129;124 08:04:19 INFO - PROCESS | 24643 | |12;stanford-crypto-pbkdf2;156;154;159;155;157;155;155;154;155;154 08:04:19 INFO - PROCESS | 24643 | |13;stanford-crypto-sha256-iterative;62;62;61;65;62;66;61;60;61;59 08:04:19 INFO - PROCESS | 24643 | __end_tp_report 08:04:19 INFO - PROCESS | 24643 | __start_cc_report 08:04:19 INFO - PROCESS | 24643 | _x_x_mozilla_cycle_collect,1585 08:04:19 INFO - PROCESS | 24643 | __end_cc_report 08:04:19 INFO - PROCESS | 24643 | __startTimestamp1467039859863__endTimestamp 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | ------- Summary: start ------- 08:04:19 INFO - PROCESS | 24643 | Number of tests: 14 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.75 (1.6%) stddev-sans-first:1.83 08:04:19 INFO - PROCESS | 24643 | Values: 110.0 105.0 110.0 111.0 109.0 108.0 111.0 109.0 109.0 110.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:138.00 stddev:22.26 (16.1%) stddev-sans-first:22.84 08:04:19 INFO - PROCESS | 24643 | Values: 156.0 127.0 124.0 190.0 125.0 127.0 149.0 122.0 155.0 124.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:0.71 08:04:19 INFO - PROCESS | 24643 | Values: 163.0 160.0 160.0 160.0 161.0 161.0 159.0 161.0 161.0 160.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#3] audio-fft Cycles:10 Average:85.00 Median:76.00 stddev:19.97 (26.3%) stddev-sans-first:20.85 08:04:19 INFO - PROCESS | 24643 | Values: 75.0 75.0 76.0 131.0 77.0 76.0 76.0 76.0 113.0 75.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.79 (19.8%) stddev-sans-first:17.32 08:04:19 INFO - PROCESS | 24643 | Values: 84.0 85.0 116.0 85.0 85.0 85.0 120.0 84.0 85.0 122.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:04:19 INFO - PROCESS | 24643 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.03 (0.7%) stddev-sans-first:1.00 08:04:19 INFO - PROCESS | 24643 | Values: 147.0 146.0 145.0 146.0 148.0 145.0 145.0 145.0 146.0 145.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 08:04:19 INFO - PROCESS | 24643 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 97.0 94.0 96.0 94.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.50 stddev:1.17 (2.3%) stddev-sans-first:1.13 08:04:19 INFO - PROCESS | 24643 | Values: 49.0 49.0 50.0 50.0 51.0 53.0 50.0 51.0 50.0 51.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.71 (2.9%) stddev-sans-first:1.81 08:04:19 INFO - PROCESS | 24643 | Values: 60.0 60.0 59.0 60.0 60.0 65.0 60.0 59.0 61.0 60.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:77.00 stddev:9.55 (12.4%) stddev-sans-first:9.89 08:04:19 INFO - PROCESS | 24643 | Values: 75.0 76.0 76.0 82.0 77.0 77.0 81.0 82.0 107.0 76.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.50 stddev:3.77 (3.1%) stddev-sans-first:4.00 08:04:19 INFO - PROCESS | 24643 | Values: 122.0 118.0 125.0 120.0 118.0 124.0 123.0 117.0 129.0 124.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:155.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 08:04:19 INFO - PROCESS | 24643 | Values: 156.0 154.0 159.0 155.0 157.0 155.0 155.0 154.0 155.0 154.0 08:04:19 INFO - PROCESS | 24643 | 08:04:19 INFO - PROCESS | 24643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:2.13 (3.4%) stddev-sans-first:2.26 08:04:19 INFO - PROCESS | 24643 | Values: 62.0 62.0 61.0 65.0 62.0 66.0 61.0 60.0 61.0 59.0 08:04:19 INFO - PROCESS | 24643 | -------- Summary: end -------- 08:04:19 INFO - PROCESS | 24643 | 08:04:20 INFO - TEST-INFO | 24643: exit 0 08:04:20 INFO - TEST-OK | kraken | took 59983ms 08:04:20 INFO - SUITE-END | took 1173s 08:04:21 INFO - Completed test suite (00:19:33) 08:04:21 INFO - javascript benchmark 08:04:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3413.453847384418, 3431.502432147339, 3442.053435305291, 3463.774854634447, 3482.860685572577, 5648.943510564893, 5730.341010783761, 5740.5981581289325, 5755.0504166812425, 5757.136429535566, 5635.6618602883855, 5723.0, 5728.513076388502, 5728.570357223204, 5733.684647344395, 4981.5516603505675, 5078.771455284521, 5154.974225128888, 5182.766775495093, 5218.139007063849, 5038.470960549144, 5128.410232823236, 5173.534381905628, 5176.974115129438, 5189.558887494568, 5139.25480805283, 5179.533841954223, 5192.506711862367, 5211.661242019276, 5232.73836308183, 5276.050310944029, 5290.55030322423, 5295.258663787073, 5298.867528311785, 5328.6802791832615, 4989.326440930464, 5118.718470484122, 5152.484751524855, 5176.197689358156, 5188.273641690166, 5485.478879506481, 5485.61600687952, 5522.420145884705, 5524.088525393306, 5544.306961629796, 6066.792477257004, 6079.659356019725, 6079.726412311456, 6091.664958427285, 6096.939030609681, 5999.730012149464, 6061.333253342129, 6076.817695469143, 6084.5132389408745, 6086.150718919058, 5636.830895073154, 5692.231548740909, 5698.059820129673, 5698.487136157724, 5706.3152421709665, 5980.162777211194, 6113.877722445526, 6120.540959427972, 6133.101782541855, 6134.2332208473945, 5897.616654917417, 5915.940840591625, 5938.673372964442, 6035.818925432244, 6059.7273122709585, 6072.635641861502, 6086.904357215743, 6089.543284253698, 6090.116933044684, 6111.877762444815, 5842.298924129132, 5937.287525496968, 6067.726952287069, 6070.544709146831, 6075.939240607626, 5957.553183511254, 5983.700814959235, 6014.308354539196, 6015.398460154037, 6059.121427393004, 4571.245744452128, 4589.059242855206, 4602.930956035662, 4609.216433206363, 4612.262038073892, 4031.0930040741187, 4061.6750659947133, 4097.13960068383, 4118.361653943643, 4131.876043718693, 5741.167530708108, 5745.368009518949, 5765.654060756284, 5768.394318596571, 5796.652200867961, 6036.215292012098, 6086.482648974887, 6093.969530152321, 6096.963516202256, 6128.448439640454, 5527.309086364205, 5722.799702010409, 5752.9712351437975, 5766.94233057664, 5782.768689252467, 5241.475852414805, 5241.68549887008, 5244.108501554745, 5251.553617942518, 5258.106121959276, 6347.460465860361, 6353.872922541524, 6356.300806911328, 6362.618242905441, 6367.076773867856, 5954.553408494294, 6017.338092809875, 6062.848428789315, 6064.969675151596, 6131.294901086254, 6298.937010630018, 6308.179936608211, 6336.524760642878, 6358.300586935526, 6359.49124070064, 5751.626144300774, 6016.639001659914, 6031.668258245839, 6047.727852246748, 6052.878942421215, 5979.730912108878, 5999.760009599741, 6031.668258245839, 6079.0, 6101.633901965896, 5863.882722345615, 5911.467967882912, 5912.408759124053, 5915.733791979457, 5922.378150294157, 5705.058665320175, 5839.0, 5890.734916928663, 5893.469587737124, 5933.050711886078, 5739.713014349182, 5743.942560574341, 5802.82591522255, 5827.4172582741385, 5849.093390524476, 5858.297004359334, 5863.94136058651, 6002.8499287516415, 6010.729517171825, 6014.849628759316, 5647.0964645656495, 5763.106718458645, 5841.386654401226, 5842.357340692605, 5863.325717542537], "value": 5590.274945747181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.6722203621064, 656.671664167916, 658.578509753758, 670.4301343857721, 670.7819958513481, 31919.52120718191, 34413.65586344139, 44763.10473790526, 45868.311975320394, 46006.0, 47880.521194788045, 48168.51831481684, 48266.27600585985, 48321.51678483214, 48361.758191208995, 9120.361574689758, 9205.079492050809, 9211.078892110801, 9270.07299270071, 9281.535923203846, 8370.916290837074, 10754.623588174416, 10908.0, 10961.0, 11205.719857003558, 11003.669889903276, 11081.113510919107, 11090.889091109108, 11098.223124381297, 11101.72245693856, 8284.378671599654, 8486.27866631337, 10841.620543280987, 10891.128709703205, 10914.617988370448, 8625.870611940825, 10672.146228301717, 10973.0, 11012.944935275353, 11024.779504409948, 41468.37797433041, 41757.58242417567, 41920.95197620054, 45956.08087838224, 45975.770121149515, 3764.3036038333, 3801.3347664158937, 4024.4566983457153, 4177.916441671149, 4355.912881742347, 35298.11754706153, 35639.0, 35792.64207357945, 35818.0, 35825.28349433023, 4687.414073240845, 4785.760711964388, 4805.087033463631, 4828.082664293773, 4829.830955916526, 358190.0, 358648.0, 360304.0, 360626.0, 360907.0, 69123.65438172777, 69546.65226673834, 69652.651736741, 69705.3029469709, 69730.30269697339, 40653.0, 41617.1676566467, 41695.374569381485, 43646.0, 43685.78157109194, 17674.5581360467, 17787.822121778616, 17952.0, 17957.102144892702, 17958.19188136537, 12206.206596571194, 12590.622281331574, 12795.808062879065, 12925.28910909909, 13183.802242966363, 22444.0, 22482.32553023412, 22511.549769004527, 22536.436589085075, 22622.547549048926, 8130.674773009132, 8194.631241594143, 8372.874406883902, 8394.496330220207, 8567.4002819802, 1086.375334182848, 1146.037328643943, 1175.024729474534, 1204.1390405859852, 1293.3016171267598, 32999.50500742491, 34630.653693462744, 34644.307113858085, 34913.12717182091, 35066.0, 1173.9823902641467, 1253.529926277646, 1283.050542598489, 1292.095533126815, 1314.3428285857071, 18327.450176494727, 18392.26430942747, 18476.168572414274, 18512.722309165372, 18565.35021274249, 532627.0, 535504.0, 535935.0, 536822.0, 538130.0, 63578.682106590095, 64957.0, 64985.35014649887, 64993.350066499675, 65203.0, 1371.1704418826466, 1465.5603319004256, 1498.423107103773, 1517.9848201517843, 1538.5076775431978, 33698.326033478705, 35125.64874351224, 35289.29421411506, 35829.46255806217, 36050.0, 56128.71935640459, 56794.716026419606, 56936.71531642315, 56977.71511142418, 57041.71479142744, 396118.0, 405210.0, 405264.0, 405424.0, 406061.0, 28195.43609127847, 30495.237619059702, 31028.22429439282, 31606.525902111945, 33115.17212069718, 50828.74585627196, 51328.74335628298, 51338.0, 52019.73990130025, 52579.21131182959, 42811.357829633205, 42982.78508607437, 43225.3516197251, 43574.782126089165, 44455.55544444514, 43757.78121109374, 43792.56207438013, 44495.777521112184, 48019.51980480151, 48405.75797120992, 45888.77055614834, 46477.767611161726, 46772.0, 47027.52972470369, 47157.764211180096, 37968.0, 39928.60071399249, 40082.59917400789, 40257.79871100626, 40394.192116156926, 30306.393872121993, 30721.846390767903, 30733.53899691551, 30834.845825770728, 30858.69141308558], "value": 21723.20736834034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.55228353378345, 425.4639154665121, 427.2224551316604, 429.15456550595314, 443.27745774387745, 18732.34436794711, 19901.800981990193, 20744.066517006733, 21046.158153673834, 21088.0, 18298.725519117223, 19352.70970935437, 19372.61254774907, 19389.12748926298, 19929.800701992976, 5257.86855328617, 5361.276227709248, 5402.621816472849, 5414.972925135388, 5417.431169727181, 3955.7033222508426, 4449.977750111261, 5292.2061690746505, 5335.919961200585, 6387.808365749035, 6624.105745724314, 6638.767643132492, 6671.633060181688, 6678.365555272266, 6682.599044057348, 6453.290138084807, 6514.44627206688, 6616.569922954993, 6634.635095069769, 6644.568103073285, 3873.57390687027, 5915.260592425947, 5925.644461332334, 6585.2097748270035, 7236.529625574321, 25266.621000685005, 26239.475210495875, 26763.0, 27916.16251512458, 27923.162305130878, 2534.4804315115357, 2642.828216165943, 2659.5611724065507, 2663.227663977444, 2690.9327266818486, 15565.29956151976, 15790.684186316324, 15870.682586348208, 16748.0, 17043.57391065221, 1880.4264699266719, 1993.8105879941381, 2016.8285695715736, 2058.742657167854, 2079.8440116991287, 65174.0, 69752.0, 89050.0, 89374.5531272346, 97169.0, 9010.549472526347, 9791.265655075898, 9808.852867206855, 10442.895571044344, 10494.055535001886, 14117.223552704494, 14223.146611203361, 14251.857481425053, 14319.713605728035, 14344.067635603653, 7840.882386764203, 8116.107228204893, 8202.794930126794, 8310.584470776437, 8333.791655208668, 7957.482763620346, 8081.838363232702, 8118.553479558563, 8145.79635509117, 8299.128591497927, 4335.393044973706, 4351.564843515623, 4364.956350436455, 4423.049044455457, 4441.71128876622, 1941.8640695151487, 1997.3508609701905, 2010.7587089549056, 2039.5614942787372, 2044.8159665630164, 448.8889997256829, 495.91817350137546, 983.8130755156498, 1054.9081700440008, 1067.5516283161091, 11139.944300278446, 11937.820932686016, 11986.460609272604, 12015.939920300343, 12114.0, 489.85059556835506, 500.47200203784627, 509.8572399728082, 519.5038738005196, 534.188034188032, 6481.837954051187, 6514.478841692748, 6531.987541931008, 6540.771073012517, 6615.569987950767, 459438.0, 468315.0, 468509.0, 469754.0, 478314.0, 58120.999999999156, 92513.53743231241, 96268.0, 98584.50707746415, 98607.0, 458.4796256249181, 506.05115408608856, 520.786477544205, 521.0854949563492, 522.4514260026956, 9117.635294588408, 10850.240483166102, 10914.454277286262, 11631.185816992729, 11648.94175529117, 41134.38298425466, 41831.58168418277, 42263.15473690447, 42832.57167428286, 42932.78533607312, 58770.0, 58988.0, 59142.70428647829, 60754.39245607664, 60974.08538871832, 7499.175090740124, 7698.230176982257, 8030.23712747288, 8196.918030819616, 8277.0, 9690.612375504901, 13784.517541885985, 13881.930590346983, 13946.930265348608, 14240.572782816533, 11934.28394296345, 12054.939725301318, 12158.270503769802, 12303.384830758605, 12567.87432125667, 11496.425178741198, 11536.134789890624, 11706.297622142698, 11950.163488556065, 11984.0, 9027.638894444148, 12122.939385303018, 12140.514379424723, 12708.618741437771, 12778.361081946052, 8246.670133194604, 8399.0, 8429.241368276884, 8464.788380290542, 8558.657653694032, 11926.940365298118, 12250.816237756619, 12309.876901230873, 12381.442835072263, 12386.81419778686], "value": 8681.70136964552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.7927971164472, 1571.5678188498157, 1625.1955282135345, 1857.702767557191, 1970.9408717738472, 9195.678151264707, 9606.42361458313, 9631.614735410583, 9874.407535547873, 9900.554475048622, 9550.570224339905, 9748.31761776676, 9761.219102471803, 9776.951115244432, 9779.217662586994, 2213.3359992002415, 2455.9263222103364, 2530.228280374485, 2548.6941567011986, 2570.408805974627, 2567.1913347295636, 2571.2800415883585, 2576.291519832052, 2577.6004719268544, 2578.8968441262327, 2454.2023842251338, 2538.6318983747346, 2538.669972903529, 2540.9074098137794, 2541.7712405883467, 2144.3888491779844, 2431.90272389106, 2433.270018994295, 2509.849409035464, 2510.6736124303725, 2492.887820048084, 2500.1374525788574, 2522.0, 2526.759957804006, 2539.3524651214007, 9682.419054856731, 9720.854187187198, 9722.562484688135, 9723.756906077333, 9732.270079744048, 5800.738966746464, 5907.7046147692445, 5940.2871655401195, 5968.462838344526, 5974.0, 3538.610752817188, 3609.530761001079, 3655.3785856404475, 3750.718696097804, 3756.7182461315238, 1188.0792385900909, 1199.1306302930393, 1227.1900545639924, 1232.1559731583804, 1273.3951373097798, 14032.789508157386, 14072.437102515887, 14076.436942522389, 14079.225642589654, 14080.2959852008, 5058.291839142523, 5086.593072554187, 5117.130087885069, 5334.493223143795, 5343.145096784496, 11077.723056923642, 11152.2751021185, 11171.608993685182, 11176.329420234812, 11181.44092795357, 5929.229200203946, 5929.584929055011, 5938.673372964528, 5940.524758019348, 5950.9702451487465, 4832.758362081881, 5316.973415132977, 5483.890322193533, 5499.257600223998, 5577.832665020056, 4261.659067274611, 4299.634531064832, 4321.7406955582765, 4354.063876266618, 4379.277419225856, 1282.8652991435765, 1305.2755720574983, 1306.6537367597593, 1319.5447570588133, 1328.2760895312078, 1075.8224892892742, 1088.1675518228562, 1094.584058057933, 1099.340395762536, 1100.9870918754764, 6368.10846481493, 6422.6467544285515, 6448.838779030468, 6502.869942601122, 6580.322017885409, 494.1771949703775, 494.2882249560621, 495.7100096443549, 497.3385397421421, 512.9230615407644, 4454.977725111354, 4470.485894122153, 4511.8646440606835, 4529.433820772403, 4546.136234115507, 12092.334921579397, 12485.438155283035, 12500.062495312888, 12526.937365313297, 12581.622551323475, 11755.706107347214, 12294.385280736105, 12400.13199076056, 12502.312372819582, 12527.248365098123, 8901.154390333037, 9247.398919070374, 9279.118483744034, 9281.767955801024, 9317.068293170765, 6615.933840661532, 6765.1205343305055, 6810.9318906810295, 6830.077939478107, 6862.073620061228, 11058.115350771757, 11346.319220846775, 11494.02300804441, 11525.654230373102, 11608.071354291467, 11470.483828227916, 11600.5359785611, 11603.5358585659, 11605.88394116048, 11686.474108664961, 7839.294463498312, 8115.310198633182, 8116.553589552395, 8794.780130496789, 9002.459852408876, 8987.730368088967, 9178.173964343241, 9476.763080923032, 9503.144716975505, 9749.512524373895, 8458.0, 8713.91286087131, 8749.08134645853, 8798.824023519623, 8878.73363799087, 8318.70884519039, 8356.749297521084, 8490.108538603605, 8513.489190648581, 8552.743417697478, 7983.321417679563, 8033.19668033192, 8073.959630201812, 8083.353331733565, 8083.8383232333845, 5691.800786972436, 5837.153612726216, 5903.616264942765, 5906.283406580361, 5992.370801065826, 5452.972735136299, 5507.862303442446, 5572.832815015556, 5745.712714364348, 5775.9133612995], "value": 5026.429207601178, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.8827910231419, 342.6641890946872, 350.20154048768813, 350.5582965463516, 354.6400403590355, 5404.7838086476595, 5532.529734972527, 5542.087979647025, 5608.971955140224, 5647.209390685307, 5522.475364840334, 5542.251796007537, 5556.13858862685, 5567.6659400436, 5575.665460072399, 4345.8478953236645, 4364.912701745963, 4380.408644832939, 4402.801873915665, 4403.119376124771, 4240.830366785325, 4320.82716691332, 4351.760653164075, 4363.716358436692, 4389.341598760179, 4269.935950960738, 4287.292596721537, 4312.0, 4318.287482565373, 4320.416743739586, 4293.377460268243, 4295.763732994684, 4342.935980684752, 4343.283358245902, 4368.410264614268, 3773.8301776420126, 3875.3411919973673, 3876.980615096935, 3881.961180388188, 3895.6493915547735, 5378.731063446812, 5423.562755869698, 5430.782768689248, 5431.646942948696, 5437.238786569844, 5026.52248036436, 5029.748512574357, 5043.193089105762, 5055.721935293557, 5123.615728820316, 5624.21261023457, 5846.736896839652, 5865.472107510344, 5902.3507414184405, 5904.232449781543, 4232.87828725388, 4272.359146128075, 4276.893077673052, 4289.463817022872, 4321.286987647034, 5980.8504787380225, 6064.211652485193, 6080.847978800522, 6137.7851775187655, 6139.815805525842, 4370.694051416371, 4380.627646650007, 4385.122975404932, 4390.792532053711, 4402.317640765622, 4384.232759267115, 4384.824607015684, 4399.076193999296, 4432.401625780542, 4434.423524941737, 4813.518648135228, 4994.250862370601, 5021.573166280907, 5025.246213068069, 5025.497450254945, 5568.164775283659, 5851.297844258716, 5851.356350801409, 5854.385289544536, 5864.618799778001, 1468.3686015013434, 1508.9924550377398, 1510.735621266274, 1520.1715065289443, 1527.2821773766311, 962.7352478068588, 970.2432102959702, 991.5884907763342, 1001.8597396364515, 1004.5278719002204, 4986.351774269322, 5008.974955125274, 5011.774470148852, 5015.921576860992, 5020.196768517019, 5257.894842103136, 5258.553022993012, 5294.205869119663, 5308.973455132699, 5319.867003324948, 4953.578945789648, 5007.324011258506, 5055.230669265801, 5234.377343023675, 5673.858153546112, 3188.3782662380613, 3202.951955720666, 3217.2761128746315, 3220.62962759281, 3241.6110066792135, 6074.271087469444, 6242.75028998844, 6253.249610046823, 6274.435300822856, 6278.340774218733, 6118.479929205978, 6147.877042459215, 6148.692565371803, 6155.384461553809, 6155.384461553898, 6142.556499222679, 6158.445739883432, 6185.134081228722, 6204.441600255998, 6208.2373343861545, 5840.824775256579, 5928.170056192223, 6005.789797357072, 6031.306399764083, 6046.879062418815, 5891.410858914246, 5893.675847828411, 5919.2179675552425, 5964.403559644001, 5973.1338955852025, 5970.164177015135, 6151.015837465984, 6192.318844927145, 6218.9378106218355, 6235.688215589294, 4310.31035034393, 4357.278874844482, 4377.0, 4381.269398587477, 4399.956000439955, 5757.280339957505, 5921.259842519685, 6017.518598512021, 6130.969345153246, 6138.846528836815, 5844.240248767633, 5846.707664616667, 5848.561357898089, 5868.474196708801, 5888.528917686661, 5802.259322203237, 5828.6211396259105, 5839.328477225174, 5846.970765146317, 5854.736536855767, 5530.723463826712, 5720.742566584597, 5770.336411312753, 5781.913271300849, 5792.913106303325, 5826.41735826414, 5829.621074630136, 5851.736671849862, 5880.235569375954, 5909.729408177091, 5472.5348345391085, 5682.5453963681975, 5740.799072032459, 5802.593818432669, 5829.59192856513], "value": 4435.852756222371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.3788245168766, 812.3176531713361, 812.3825892321837, 843.9915600843991, 895.4537731983485, 15822.208889555519, 15887.285072171751, 16025.0, 17064.402745903895, 17172.65654686907, 15921.0, 15988.280527376266, 16186.676266474664, 16196.676066478663, 16222.7566586501, 726.4442701333484, 861.1388611388611, 868.7133246028811, 895.5701263393574, 902.6975963052386, 884.7788052986754, 885.5041176940902, 888.7778055486128, 889.4752096263203, 891.3849443883732, 932.086555175928, 934.4533447932934, 934.5280633280217, 934.607464864755, 934.6681927915594, 763.4465012865655, 911.1344222988155, 932.3986029011284, 932.9626814927462, 937.161240689579, 687.089606271692, 687.5015613680092, 688.1295161620554, 688.469878193788, 689.5552368722147, 15522.456714014956, 15586.376544938188, 15593.610159745984, 15594.37622495099, 15600.375984960701, 15003.39881215234, 15076.623084422867, 15309.61725956849, 15718.685626287524, 15861.36554537817, 12097.455614497281, 12211.0, 12212.023038156925, 12372.81440778389, 12450.25298482094, 4098.631123198927, 4816.54242846929, 4889.3888263967, 4952.158133117378, 4953.331300274453, 70515.29484705138, 81198.9999999994, 81207.0, 81225.59387203085, 81288.18711812866, 12713.364331783374, 13069.934650326877, 13128.949684025256, 13161.868381316064, 13187.14283571584, 24249.878750606134, 24395.048396128266, 24428.63357049646, 24451.755482445304, 24933.0, 9405.20055795265, 9439.622415103318, 9442.291828112782, 9525.190358819578, 9660.275479339078, 5070.366204224472, 5148.639595228298, 5197.896042079213, 5307.177387504943, 5313.335833020872, 3971.602839716063, 4056.6146216109423, 4078.490188726409, 4083.14254006656, 4102.2410853992105, 648.5330561995356, 695.8051745511265, 705.4955706669654, 760.9543427394374, 801.6592947997078, 723.3706675192616, 752.8005078654161, 812.7033632724132, 818.9190268845186, 849.5794581682106, 10413.42726150054, 10480.213983951235, 10497.422641754623, 10594.682159535227, 10633.89366106329, 731.2322061835158, 765.12775436003, 800.491687778265, 813.3493205435627, 824.3858325547506, 5429.728513574306, 5544.805931792368, 5687.317521897398, 5699.430056994351, 5798.0, 124347.0, 126375.0, 127382.0, 128761.0, 133726.0, 64074.35925640777, 85966.0, 109933.0, 112022.43988780004, 112523.0, 94046.0, 96030.51984740031, 96731.0, 101144.0, 101908.0, 10898.400587967737, 10972.0, 11221.55113795439, 11231.66305010851, 11355.602553910574, 54296.728516357165, 54985.0, 55390.44609554014, 55733.721331393084, 56919.43080569307, 62298.0, 79809.60095199487, 81288.0, 82319.17680823115, 85681.0, 13947.511837085653, 14109.365078571283, 14801.0, 14832.925835370754, 15014.249287535798, 15285.847141528442, 15305.540833775005, 15638.139902305482, 15824.208789560706, 16974.236159373104, 14787.704245915236, 14882.925585372004, 15003.849961500246, 15432.151231681915, 15451.459198927983, 14814.444783023413, 14978.47575334858, 15132.621684457976, 15278.15970121654, 15589.766153507933, 14391.568252952427, 14468.565943021305, 14584.635384115481, 15049.623759405664, 15066.773998389814, 12223.511059557519, 12676.619701408972, 12861.871381286068, 12907.419166137359, 12982.350882456029, 12138.939305303416, 12395.132340736423, 12905.870941290843, 13165.736685266433, 13509.189448633113], "value": 8323.646495518818, "unit": "score"}], "name": "dromaeo_css", "value": 7619.487216415038, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 111.0, 109.0, 108.0, 111.0, 109.0, 109.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 124.0, 190.0, 125.0, 127.0, 149.0, 122.0, 155.0, 124.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 160.0, 161.0, 161.0, 159.0, 161.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 131.0, 77.0, 76.0, 76.0, 76.0, 113.0, 75.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 85.0, 85.0, 85.0, 120.0, 84.0, 85.0, 122.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 148.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 97.0, 94.0, 96.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 50.0, 50.0, 51.0, 53.0, 50.0, 51.0, 50.0, 51.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 65.0, 60.0, 59.0, 61.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 82.0, 77.0, 77.0, 81.0, 82.0, 107.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 125.0, 120.0, 118.0, 124.0, 123.0, 117.0, 129.0, 124.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 159.0, 155.0, 157.0, 155.0, 155.0, 154.0, 155.0, 154.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 65.0, 62.0, 66.0, 61.0, 60.0, 61.0, 59.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1478.7000000000005, "alertThreshold": 2.0}]} 08:04:21 INFO - Return code: 0 08:04:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:04:21 ERROR - # TBPL SUCCESS # 08:04:21 INFO - Running post-action listener: _resource_record_post_action 08:04:21 INFO - ##### 08:04:21 INFO - ##### Finished run-tests step (success) 08:04:21 INFO - ##### 08:04:21 INFO - Running post-run listener: _resource_record_post_run 08:04:21 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 480210944; Read time: 16; Write time: 388792 08:04:21 INFO - TinderboxPrint: CPU usage
13.1% 08:04:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:04:21 INFO - TinderboxPrint: I/O write bytes / time
480,210,944 / 388,792 08:04:21 INFO - TinderboxPrint: CPU idle
8,252.6 (86.9%) 08:04:21 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 08:04:21 INFO - TinderboxPrint: Swap in / out
0 / 0 08:04:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 225304576; Read time: 0; Write time: 247800 08:04:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254177280; Read time: 16; Write time: 140968 08:04:21 INFO - Running post-run listener: _upload_blobber_files 08:04:21 INFO - Blob upload gear active. 08:04:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:04:21 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 08:04:21 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'] 08:04:21 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 08:04:22 INFO - (blobuploader) - INFO - Open directory for files ... 08:04:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:04:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:04:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:22 INFO - (blobuploader) - INFO - Done attempting. 08:04:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:04:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:04:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:26 INFO - (blobuploader) - INFO - Done attempting. 08:04:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:04:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:04:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:27 INFO - (blobuploader) - INFO - Done attempting. 08:04:27 INFO - (blobuploader) - INFO - Iteration through files over. 08:04:27 INFO - Return code: 0 08:04:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:04:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:04:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68ac91c28b7f1545051225871bc45908ddef32081835d7416d507b444ba9f1fa71188118a21e2f52e433cdb83fc5e9ec22478ec568fdcda5caa5687ffb8631ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5e45e58467d520b01233b5b81ad7dbe6b2afc5ddedaa77f7f85a91d2a7082e9959f40d1eee8a52da05ea72555048831776af7d8348ac5ca4e4e4bb6f137293f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd9176ceec226153aa28d60edaad1849ed7d138a23bf28a730c8594e4cf955389f5a8edaf8508dab086bf4176514b6868613485750dc7161883b2931b6c8896"} 08:04:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:04:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:04:27 INFO - Contents: 08:04:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68ac91c28b7f1545051225871bc45908ddef32081835d7416d507b444ba9f1fa71188118a21e2f52e433cdb83fc5e9ec22478ec568fdcda5caa5687ffb8631ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5e45e58467d520b01233b5b81ad7dbe6b2afc5ddedaa77f7f85a91d2a7082e9959f40d1eee8a52da05ea72555048831776af7d8348ac5ca4e4e4bb6f137293f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd9176ceec226153aa28d60edaad1849ed7d138a23bf28a730c8594e4cf955389f5a8edaf8508dab086bf4176514b6868613485750dc7161883b2931b6c8896"} 08:04:27 INFO - Running post-run listener: copy_logs_to_upload_dir 08:04:27 INFO - Copying logs to upload dir... 08:04:27 INFO - mkdir: /builds/slave/test/build/upload/logs 08:04:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.527122 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-27 08:04:27.005676) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:04:27.009807) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544 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/68ac91c28b7f1545051225871bc45908ddef32081835d7416d507b444ba9f1fa71188118a21e2f52e433cdb83fc5e9ec22478ec568fdcda5caa5687ffb8631ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5e45e58467d520b01233b5b81ad7dbe6b2afc5ddedaa77f7f85a91d2a7082e9959f40d1eee8a52da05ea72555048831776af7d8348ac5ca4e4e4bb6f137293f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd9176ceec226153aa28d60edaad1849ed7d138a23bf28a730c8594e4cf955389f5a8edaf8508dab086bf4176514b6868613485750dc7161883b2931b6c8896"} build_url:https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/FK-vFQT4R4mn14bhZuyNVA/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/68ac91c28b7f1545051225871bc45908ddef32081835d7416d507b444ba9f1fa71188118a21e2f52e433cdb83fc5e9ec22478ec568fdcda5caa5687ffb8631ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5e45e58467d520b01233b5b81ad7dbe6b2afc5ddedaa77f7f85a91d2a7082e9959f40d1eee8a52da05ea72555048831776af7d8348ac5ca4e4e4bb6f137293f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd9176ceec226153aa28d60edaad1849ed7d138a23bf28a730c8594e4cf955389f5a8edaf8508dab086bf4176514b6868613485750dc7161883b2931b6c8896"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:04:27.036289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:04:27.036621) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467037027.863399-1172917544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:04:27.120026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:04:27.120369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:04:27.120666) ========= ========= Total master_lag: 0.17 =========