builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1469188505.13 results: success (0) buildid: 20160722032325 builduid: 09531eaab9fb46df957113a8c20507fc revision: 8fd80dfc8f7df45c301780c94650e66c06ef077e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.134722) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.135178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.135469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.158572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.158838) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 04:55:05-- 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% 224M=0s 2016-07-22 04:55:05 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137006 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.859294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.859611) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022244 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.894259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:05.894647) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8fd80dfc8f7df45c301780c94650e66c06ef077e --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 8fd80dfc8f7df45c301780c94650e66c06ef077e --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=2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 04:55:06,054 truncating revision to first 12 chars 2016-07-22 04:55:06,054 Setting DEBUG logging. 2016-07-22 04:55:06,054 attempt 1/10 2016-07-22 04:55:06,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8fd80dfc8f7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 04:55:06,360 unpacking tar archive at: mozilla-aurora-8fd80dfc8f7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:06.552187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:06.552495) ========= script_repo_revision: 8fd80dfc8f7df45c301780c94650e66c06ef077e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:06.552884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:06.553171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 04:55:06.565064) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-22 04:55:06.565581) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:55:06 INFO - MultiFileLogger online at 20160722 04:55:06 in /builds/slave/test 04:55:06 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 04:55:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:55:06 INFO - {'append_to_log': False, 04:55:06 INFO - 'base_work_dir': '/builds/slave/test', 04:55:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:55:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:55:06 INFO - 'branch': 'Mozilla-Aurora', 04:55:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:06 INFO - 'config_files': ('talos/linux_config.py',), 04:55:06 INFO - 'default_actions': ('clobber', 04:55:06 INFO - 'read-buildbot-config', 04:55:06 INFO - 'download-and-extract', 04:55:06 INFO - 'populate-webroot', 04:55:06 INFO - 'create-virtualenv', 04:55:06 INFO - 'install', 04:55:06 INFO - 'run-tests'), 04:55:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:06 INFO - 'download_minidump_stackwalk': True, 04:55:06 INFO - 'download_symbols': 'ondemand', 04:55:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:06 INFO - 'installer_path': 'installer.exe', 04:55:06 INFO - 'log_level': 'info', 04:55:06 INFO - 'log_name': 'talos', 04:55:06 INFO - 'log_to_console': True, 04:55:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:55:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:55:06 INFO - 'opt_config_files': (), 04:55:06 INFO - 'pip_index': False, 04:55:06 INFO - 'sps_profile': False, 04:55:06 INFO - 'sps_profile_interval': 0, 04:55:06 INFO - 'suite': 'dromaeojs', 04:55:06 INFO - 'system_bits': '32', 04:55:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:06 INFO - 'title': 'talos-linux64-ix-012', 04:55:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:06 INFO - 'use_talos_json': True, 04:55:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:55:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:06 INFO - 'work_dir': 'build'} 04:55:06 INFO - ##### 04:55:06 INFO - ##### Running clobber step. 04:55:06 INFO - ##### 04:55:06 INFO - Running pre-action listener: _resource_record_pre_action 04:55:06 INFO - Running main action method: clobber 04:55:06 INFO - rmtree: /builds/slave/test/build 04:55:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:55:07 INFO - Running post-action listener: _resource_record_post_action 04:55:07 INFO - ##### 04:55:07 INFO - ##### Finished clobber step (success) 04:55:07 INFO - ##### 04:55:07 INFO - ##### 04:55:07 INFO - ##### Running read-buildbot-config step. 04:55:07 INFO - ##### 04:55:07 INFO - Running pre-action listener: _resource_record_pre_action 04:55:07 INFO - Running main action method: read_buildbot_config 04:55:07 INFO - Using buildbot properties: 04:55:07 INFO - { 04:55:07 INFO - "project": "", 04:55:07 INFO - "product": "firefox", 04:55:07 INFO - "script_repo_revision": "production", 04:55:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:55:07 INFO - "repository": "", 04:55:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:55:07 INFO - "buildid": "20160722032325", 04:55:07 INFO - "pgo_build": "True", 04:55:07 INFO - "basedir": "/builds/slave/test", 04:55:07 INFO - "buildnumber": 623, 04:55:07 INFO - "slavename": "talos-linux64-ix-012", 04:55:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:55:07 INFO - "platform": "ubuntu64_hw", 04:55:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:55:07 INFO - "branch": "mozilla-aurora", 04:55:07 INFO - "repo_path": "releases/mozilla-aurora", 04:55:07 INFO - "revision": "8fd80dfc8f7df45c301780c94650e66c06ef077e", 04:55:07 INFO - "stage_platform": "linux64-pgo", 04:55:07 INFO - "builduid": "09531eaab9fb46df957113a8c20507fc", 04:55:07 INFO - "slavebuilddir": "test" 04:55:07 INFO - } 04:55:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:55:07 INFO - Running post-action listener: _resource_record_post_action 04:55:07 INFO - ##### 04:55:07 INFO - ##### Finished read-buildbot-config step (success) 04:55:07 INFO - ##### 04:55:07 INFO - ##### 04:55:07 INFO - ##### Running download-and-extract step. 04:55:07 INFO - ##### 04:55:07 INFO - Running pre-action listener: _resource_record_pre_action 04:55:07 INFO - Running main action method: download_and_extract 04:55:07 INFO - mkdir: /builds/slave/test/build/tests 04:55: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')]} 04:55:07 INFO - https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:55:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:55:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:55:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:07 INFO - Downloaded 1361 bytes. 04:55:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:55:07 INFO - Using the following test package requirements: 04:55:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:55:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:55:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:55:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'jsshell-linux-x86_64.zip'], 04:55:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:55:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:55:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:55:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:55:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:55:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:55:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:55:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:55: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')]} 04:55:07 INFO - https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:55:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:55:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:55:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:13 INFO - Downloaded 24490618 bytes. 04:55:13 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'] 04:55:13 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 04:55:14 INFO - Return code: 0 04:55:14 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:14 INFO - https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:55:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:55:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:55:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:24 INFO - Downloaded 24490618 bytes. 04:55:24 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'] 04:55:24 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 04:55:26 INFO - Return code: 0 04:55: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')]} 04:55:26 INFO - https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:55:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:55:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:55:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:27 INFO - Downloaded 10833369 bytes. 04:55:27 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'] 04:55:27 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 04:55:27 INFO - Return code: 0 04:55: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')]} 04:55:27 INFO - https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PWpnF-NtTzak_AI3EuYtRg/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 04:55:28 INFO - Downloaded 63639733 bytes. 04:55:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:55:28 INFO - mkdir: /builds/slave/test/properties 04:55:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:55:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:55:28 INFO - Contents: 04:55:28 INFO - build_url:https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:55:29 INFO - Running post-action listener: _resource_record_post_action 04:55:29 INFO - Running post-action listener: set_extra_try_arguments 04:55:29 INFO - ##### 04:55:29 INFO - ##### Finished download-and-extract step (success) 04:55:29 INFO - ##### 04:55:29 INFO - ##### 04:55:29 INFO - ##### Running populate-webroot step. 04:55:29 INFO - ##### 04:55:29 INFO - Running pre-action listener: _resource_record_pre_action 04:55:29 INFO - Running main action method: populate_webroot 04:55:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:55:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:55:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:55:29 INFO - '--tppagecycles', 04:55:29 INFO - '7'], 04:55:29 INFO - 'tests': ['tsvgm']}}, 04:55:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:55:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:55:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:55:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:55:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['damp', 'tps']}, 04:55:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'tests': ['damp', 'tps']}, 04:55:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['dromaeo_dom']}, 04:55:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:55:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['a11yr', 04:55:29 INFO - 'ts_paint', 04:55:29 INFO - 'tpaint', 04:55:29 INFO - 'sessionrestore', 04:55:29 INFO - 'sessionrestore_no_auto_restore', 04:55:29 INFO - 'tabpaint']}, 04:55:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:55:29 INFO - 'ts_paint', 04:55:29 INFO - 'tpaint', 04:55:29 INFO - 'sessionrestore', 04:55:29 INFO - 'sessionrestore_no_auto_restore', 04:55:29 INFO - 'tabpaint']}, 04:55:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:55:29 INFO - 'ts_paint', 04:55:29 INFO - 'tpaint', 04:55:29 INFO - 'sessionrestore', 04:55:29 INFO - 'sessionrestore_no_auto_restore', 04:55:29 INFO - 'tabpaint']}, 04:55:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:55:29 INFO - 'ts_paint', 04:55:29 INFO - 'tpaint', 04:55:29 INFO - 'sessionrestore', 04:55:29 INFO - 'sessionrestore_no_auto_restore', 04:55:29 INFO - 'tabpaint']}, 04:55:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['a11yr', 04:55:29 INFO - 'ts_paint', 04:55:29 INFO - 'tpaint', 04:55:29 INFO - 'sessionrestore', 04:55:29 INFO - 'sessionrestore_no_auto_restore', 04:55:29 INFO - 'tabpaint']}, 04:55:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['a11yr', 04:55:29 INFO - 'ts_paint', 04:55:29 INFO - 'tpaint', 04:55:29 INFO - 'sessionrestore', 04:55:29 INFO - 'sessionrestore_no_auto_restore', 04:55:29 INFO - 'tabpaint']}, 04:55:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['tsvgx', 04:55:29 INFO - 'tsvgr_opacity', 04:55:29 INFO - 'tart', 04:55:29 INFO - 'tscrollx', 04:55:29 INFO - 'cart']}, 04:55:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:55:29 INFO - 'tsvgr_opacity', 04:55:29 INFO - 'tart', 04:55:29 INFO - 'tscrollx', 04:55:29 INFO - 'cart']}, 04:55:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'talos_options': ['--disable-e10s'], 04:55:29 INFO - 'tests': ['tp5o']}, 04:55:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'tests': ['tp5o']}, 04:55:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'talos_options': ['--disable-e10s', 04:55:29 INFO - '--xperf_path', 04:55:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:29 INFO - 'tests': ['tp5n']}, 04:55:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:29 INFO - 'talos_options': ['--xperf_path', 04:55:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:29 INFO - 'tests': ['tp5n']}}, 04:55:29 INFO - 'talos.zip': {'path': '', 04:55:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:55:29 INFO - Running post-action listener: _resource_record_post_action 04:55:29 INFO - ##### 04:55:29 INFO - ##### Finished populate-webroot step (success) 04:55:29 INFO - ##### 04:55:29 INFO - ##### 04:55:29 INFO - ##### Running create-virtualenv step. 04:55:29 INFO - ##### 04:55:29 INFO - Running pre-action listener: _resource_record_pre_action 04:55:29 INFO - Running main action method: create_virtualenv 04:55:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:55:29 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 04:55:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:55:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:55:29 INFO - Using real prefix '/usr' 04:55:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:55:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:32 INFO - Installing pip.................done. 04:55:32 INFO - Return code: 0 04:55:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:55:32 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')]} 04:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:32 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')]} 04:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:32 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:32 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 04:55:32 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 04:55:32 INFO - Using env: {'DISPLAY': ':0', 04:55:32 INFO - 'HOME': '/home/cltbld', 04:55:32 INFO - 'LANG': 'en_US.UTF-8', 04:55:32 INFO - 'LANGUAGE': 'en_US:en', 04:55:32 INFO - 'LOGNAME': 'cltbld', 04:55:32 INFO - 'MAIL': '/var/mail/cltbld', 04:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:32 INFO - 'MOZ_NO_REMOTE': '1', 04:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:32 INFO - 'NO_EM_RESTART': '1', 04:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:32 INFO - 'PWD': '/builds/slave/test', 04:55:32 INFO - 'SHELL': '/bin/bash', 04:55:32 INFO - 'SHLVL': '1', 04:55:32 INFO - 'TERM': 'linux', 04:55:32 INFO - 'TMOUT': '86400', 04:55:32 INFO - 'USER': 'cltbld', 04:55:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:32 INFO - '_': '/tools/buildbot/bin/python'} 04:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:32 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 04:55:32 INFO - Cleaning up... 04:55:32 INFO - Return code: 0 04:55:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:55:32 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')]} 04:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:32 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')]} 04:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:32 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:32 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 04:55:32 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 04:55:32 INFO - Using env: {'DISPLAY': ':0', 04:55:32 INFO - 'HOME': '/home/cltbld', 04:55:32 INFO - 'LANG': 'en_US.UTF-8', 04:55:32 INFO - 'LANGUAGE': 'en_US:en', 04:55:32 INFO - 'LOGNAME': 'cltbld', 04:55:32 INFO - 'MAIL': '/var/mail/cltbld', 04:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:32 INFO - 'MOZ_NO_REMOTE': '1', 04:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:32 INFO - 'NO_EM_RESTART': '1', 04:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:32 INFO - 'PWD': '/builds/slave/test', 04:55:32 INFO - 'SHELL': '/bin/bash', 04:55:32 INFO - 'SHLVL': '1', 04:55:32 INFO - 'TERM': 'linux', 04:55:32 INFO - 'TMOUT': '86400', 04:55:32 INFO - 'USER': 'cltbld', 04:55:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:32 INFO - '_': '/tools/buildbot/bin/python'} 04:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:32 INFO - Downloading/unpacking psutil>=3.1.1 04:55:32 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 04:55:32 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 04:55:32 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 04:55:32 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 04:55:32 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 04:55:32 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 04:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:55:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:34 INFO - Installing collected packages: psutil 04:55:34 INFO - Running setup.py install for psutil 04:55:34 INFO - building 'psutil._psutil_linux' extension 04:55:34 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 04:55:35 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 04:55:35 INFO - building 'psutil._psutil_posix' extension 04:55:35 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 04:55:35 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 04:55:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:35 INFO - Successfully installed psutil 04:55:35 INFO - Cleaning up... 04:55:35 INFO - Return code: 0 04:55:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:55:35 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')]} 04:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:35 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')]} 04:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:35 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:35 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 04:55:35 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 04:55:35 INFO - Using env: {'DISPLAY': ':0', 04:55:35 INFO - 'HOME': '/home/cltbld', 04:55:35 INFO - 'LANG': 'en_US.UTF-8', 04:55:35 INFO - 'LANGUAGE': 'en_US:en', 04:55:35 INFO - 'LOGNAME': 'cltbld', 04:55:35 INFO - 'MAIL': '/var/mail/cltbld', 04:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:35 INFO - 'MOZ_NO_REMOTE': '1', 04:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:35 INFO - 'NO_EM_RESTART': '1', 04:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:35 INFO - 'PWD': '/builds/slave/test', 04:55:35 INFO - 'SHELL': '/bin/bash', 04:55:35 INFO - 'SHLVL': '1', 04:55:35 INFO - 'TERM': 'linux', 04:55:35 INFO - 'TMOUT': '86400', 04:55:35 INFO - 'USER': 'cltbld', 04:55:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:35 INFO - '_': '/tools/buildbot/bin/python'} 04:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:55:35 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 04:55:35 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 04:55:35 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 04:55:35 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 04:55:35 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 04:55:35 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 04:55:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:55:37 INFO - Installing collected packages: mozsystemmonitor 04:55:37 INFO - Running setup.py install for mozsystemmonitor 04:55:37 INFO - Successfully installed mozsystemmonitor 04:55:37 INFO - Cleaning up... 04:55:37 INFO - Return code: 0 04:55:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:37 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:37 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 04:55:37 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 04:55:37 INFO - Using env: {'DISPLAY': ':0', 04:55:37 INFO - 'HOME': '/home/cltbld', 04:55:37 INFO - 'LANG': 'en_US.UTF-8', 04:55:37 INFO - 'LANGUAGE': 'en_US:en', 04:55:37 INFO - 'LOGNAME': 'cltbld', 04:55:37 INFO - 'MAIL': '/var/mail/cltbld', 04:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:37 INFO - 'MOZ_NO_REMOTE': '1', 04:55:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:37 INFO - 'NO_EM_RESTART': '1', 04:55:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:37 INFO - 'PWD': '/builds/slave/test', 04:55:37 INFO - 'SHELL': '/bin/bash', 04:55:37 INFO - 'SHLVL': '1', 04:55:37 INFO - 'TERM': 'linux', 04:55:37 INFO - 'TMOUT': '86400', 04:55:37 INFO - 'USER': 'cltbld', 04:55:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:37 INFO - '_': '/tools/buildbot/bin/python'} 04:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:55:37 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 04:55:37 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 04:55:37 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 04:55:37 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 04:55:37 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 04:55:37 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 04:55:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:40 INFO - warning: no files found matching '*.txt' 04:55:40 INFO - no previously-included directories found matching 'build' 04:55:40 INFO - no previously-included directories found matching 'dist' 04:55:40 INFO - no previously-included directories found matching '.git*' 04:55:40 INFO - Installing collected packages: jsonschema, functools32 04:55:40 INFO - Running setup.py install for functools32 04:55:40 INFO - warning: no files found matching '*.txt' 04:55:40 INFO - no previously-included directories found matching 'build' 04:55:40 INFO - no previously-included directories found matching 'dist' 04:55:40 INFO - no previously-included directories found matching '.git*' 04:55:40 INFO - Successfully installed jsonschema functools32 04:55:40 INFO - Cleaning up... 04:55:40 INFO - Return code: 0 04:55:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:40 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:40 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 04:55:40 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 04:55:40 INFO - Using env: {'DISPLAY': ':0', 04:55:40 INFO - 'HOME': '/home/cltbld', 04:55:40 INFO - 'LANG': 'en_US.UTF-8', 04:55:40 INFO - 'LANGUAGE': 'en_US:en', 04:55:40 INFO - 'LOGNAME': 'cltbld', 04:55:40 INFO - 'MAIL': '/var/mail/cltbld', 04:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:40 INFO - 'MOZ_NO_REMOTE': '1', 04:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:40 INFO - 'NO_EM_RESTART': '1', 04:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:40 INFO - 'PWD': '/builds/slave/test', 04:55:40 INFO - 'SHELL': '/bin/bash', 04:55:40 INFO - 'SHLVL': '1', 04:55:40 INFO - 'TERM': 'linux', 04:55:40 INFO - 'TMOUT': '86400', 04:55:40 INFO - 'USER': 'cltbld', 04:55:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:40 INFO - '_': '/tools/buildbot/bin/python'} 04:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:55:40 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 04:55:40 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 04:55:40 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 04:55:40 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 04:55:40 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 04:55:40 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 04:55:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:55:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:43 INFO - Downloading docopt-0.6.1.tar.gz 04:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:43 INFO - Running setup.py install for blobuploader 04:55:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:55:43 INFO - Running setup.py install for requests 04:55:43 INFO - Running setup.py install for docopt 04:55:43 INFO - Successfully installed blobuploader requests docopt 04:55:43 INFO - Cleaning up... 04:55:43 INFO - Return code: 0 04:55:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:43 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')]} 04:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:43 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')]} 04:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:43 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:43 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 04:55:43 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 04:55:43 INFO - Using env: {'DISPLAY': ':0', 04:55:43 INFO - 'HOME': '/home/cltbld', 04:55:43 INFO - 'LANG': 'en_US.UTF-8', 04:55:43 INFO - 'LANGUAGE': 'en_US:en', 04:55:43 INFO - 'LOGNAME': 'cltbld', 04:55:43 INFO - 'MAIL': '/var/mail/cltbld', 04:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:43 INFO - 'MOZ_NO_REMOTE': '1', 04:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:43 INFO - 'NO_EM_RESTART': '1', 04:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:43 INFO - 'PWD': '/builds/slave/test', 04:55:43 INFO - 'SHELL': '/bin/bash', 04:55:43 INFO - 'SHLVL': '1', 04:55:43 INFO - 'TERM': 'linux', 04:55:43 INFO - 'TMOUT': '86400', 04:55:43 INFO - 'USER': 'cltbld', 04:55:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:43 INFO - '_': '/tools/buildbot/bin/python'} 04:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:43 INFO - Running setup.py (path:/tmp/pip-sW9qyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:44 INFO - Running setup.py (path:/tmp/pip-x11Cjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:44 INFO - Running setup.py (path:/tmp/pip-tvX_sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:44 INFO - Running setup.py (path:/tmp/pip-DCTxxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:44 INFO - Running setup.py (path:/tmp/pip-aiaQ9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:44 INFO - Running setup.py (path:/tmp/pip-gCKBQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:44 INFO - Running setup.py (path:/tmp/pip-wghVIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:44 INFO - Running setup.py (path:/tmp/pip-pAETUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:44 INFO - Running setup.py (path:/tmp/pip-6h9S7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:44 INFO - Running setup.py (path:/tmp/pip-rkzlGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:44 INFO - Running setup.py (path:/tmp/pip-el_bEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:44 INFO - Running setup.py (path:/tmp/pip-jS6vcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:44 INFO - Running setup.py (path:/tmp/pip-WPoGvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:44 INFO - Running setup.py (path:/tmp/pip-7Lav9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:45 INFO - Running setup.py (path:/tmp/pip-vTUBWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:45 INFO - Running setup.py (path:/tmp/pip-kWWyNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:45 INFO - Running setup.py (path:/tmp/pip-FNB3KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:55:45 INFO - Running setup.py install for manifestparser 04:55:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:55:45 INFO - Running setup.py install for mozcrash 04:55:45 INFO - Running setup.py install for mozdebug 04:55:45 INFO - Running setup.py install for mozdevice 04:55:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:55:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:55:45 INFO - Running setup.py install for mozfile 04:55:45 INFO - Running setup.py install for mozhttpd 04:55:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:55:45 INFO - Running setup.py install for mozinfo 04:55:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:55:45 INFO - Running setup.py install for mozInstall 04:55:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Running setup.py install for mozleak 04:55:46 INFO - Running setup.py install for mozlog 04:55:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Running setup.py install for moznetwork 04:55:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Running setup.py install for mozprocess 04:55:46 INFO - Running setup.py install for mozprofile 04:55:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Running setup.py install for mozrunner 04:55:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Running setup.py install for mozscreenshot 04:55:46 INFO - Running setup.py install for moztest 04:55:46 INFO - Running setup.py install for mozversion 04:55:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:55:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:55:46 INFO - Cleaning up... 04:55:47 INFO - Return code: 0 04:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:47 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:47 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 04:55:47 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 04:55:47 INFO - Using env: {'DISPLAY': ':0', 04:55:47 INFO - 'HOME': '/home/cltbld', 04:55:47 INFO - 'LANG': 'en_US.UTF-8', 04:55:47 INFO - 'LANGUAGE': 'en_US:en', 04:55:47 INFO - 'LOGNAME': 'cltbld', 04:55:47 INFO - 'MAIL': '/var/mail/cltbld', 04:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:47 INFO - 'MOZ_NO_REMOTE': '1', 04:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:47 INFO - 'NO_EM_RESTART': '1', 04:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:47 INFO - 'PWD': '/builds/slave/test', 04:55:47 INFO - 'SHELL': '/bin/bash', 04:55:47 INFO - 'SHLVL': '1', 04:55:47 INFO - 'TERM': 'linux', 04:55:47 INFO - 'TMOUT': '86400', 04:55:47 INFO - 'USER': 'cltbld', 04:55:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:47 INFO - '_': '/tools/buildbot/bin/python'} 04:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:47 INFO - Running setup.py (path:/tmp/pip-Jr7YRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:47 INFO - Running setup.py (path:/tmp/pip-owijeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:47 INFO - Running setup.py (path:/tmp/pip-l9P0xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:47 INFO - Running setup.py (path:/tmp/pip-DskfeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:47 INFO - Running setup.py (path:/tmp/pip-C7cFTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:47 INFO - Running setup.py (path:/tmp/pip-J0xI2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:47 INFO - Running setup.py (path:/tmp/pip-dPPhdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:47 INFO - Running setup.py (path:/tmp/pip-fz7vl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:47 INFO - Running setup.py (path:/tmp/pip-EPjwy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:47 INFO - Running setup.py (path:/tmp/pip-a5KoH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:47 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)) 04:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:47 INFO - Running setup.py (path:/tmp/pip-5o1yGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:48 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)) 04:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:48 INFO - Running setup.py (path:/tmp/pip-l6y70v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:48 INFO - Running setup.py (path:/tmp/pip-6IoWvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:48 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)) 04:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:48 INFO - Running setup.py (path:/tmp/pip-Fmofa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:48 INFO - Running setup.py (path:/tmp/pip-0VKQTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:48 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)) 04:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:48 INFO - Running setup.py (path:/tmp/pip-ZpUsEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:48 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)) 04:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:48 INFO - Running setup.py (path:/tmp/pip-955uhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:48 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)) 04:55:48 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)) 04:55:48 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)) 04:55:48 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)) 04:55:48 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)) 04:55:48 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)) 04:55:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:50 INFO - Downloading blessings-1.6.tar.gz 04:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:50 INFO - Installing collected packages: blessings 04:55:50 INFO - Running setup.py install for blessings 04:55:50 INFO - Successfully installed blessings 04:55:50 INFO - Cleaning up... 04:55:50 INFO - Return code: 0 04:55:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:55:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:50 INFO - Reading from file tmpfile_stdout 04:55:50 INFO - Current package versions: 04:55:50 INFO - argparse == 1.2.1 04:55:50 INFO - blessings == 1.6 04:55:50 INFO - blobuploader == 1.2.4 04:55:50 INFO - docopt == 0.6.1 04:55:50 INFO - functools32 == 3.2.3-2 04:55:50 INFO - jsonschema == 2.5.1 04:55:50 INFO - manifestparser == 1.1 04:55:50 INFO - mozInstall == 1.12 04:55:50 INFO - mozcrash == 0.17 04:55:50 INFO - mozdebug == 0.1 04:55:50 INFO - mozdevice == 0.48 04:55:50 INFO - mozfile == 1.2 04:55:50 INFO - mozhttpd == 0.7 04:55:50 INFO - mozinfo == 0.9 04:55:50 INFO - mozleak == 0.1 04:55:50 INFO - mozlog == 3.2 04:55:50 INFO - moznetwork == 0.27 04:55:50 INFO - mozprocess == 0.23 04:55:50 INFO - mozprofile == 0.28 04:55:50 INFO - mozrunner == 6.12 04:55:50 INFO - mozscreenshot == 0.1 04:55:50 INFO - mozsystemmonitor == 0.3 04:55:50 INFO - moztest == 0.7 04:55:50 INFO - mozversion == 1.4 04:55:50 INFO - psutil == 3.1.1 04:55:50 INFO - requests == 1.2.3 04:55:50 INFO - wsgiref == 0.1.2 04:55:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:50 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:50 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 04:55:50 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 04:55:50 INFO - Using env: {'DISPLAY': ':0', 04:55:50 INFO - 'HOME': '/home/cltbld', 04:55:50 INFO - 'LANG': 'en_US.UTF-8', 04:55:50 INFO - 'LANGUAGE': 'en_US:en', 04:55:50 INFO - 'LOGNAME': 'cltbld', 04:55:50 INFO - 'MAIL': '/var/mail/cltbld', 04:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:50 INFO - 'MOZ_NO_REMOTE': '1', 04:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:50 INFO - 'NO_EM_RESTART': '1', 04:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:50 INFO - 'PWD': '/builds/slave/test', 04:55:50 INFO - 'SHELL': '/bin/bash', 04:55:50 INFO - 'SHLVL': '1', 04:55:50 INFO - 'TERM': 'linux', 04:55:50 INFO - 'TMOUT': '86400', 04:55:50 INFO - 'USER': 'cltbld', 04:55:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:50 INFO - '_': '/tools/buildbot/bin/python'} 04:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 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)) 04:55:51 INFO - Cleaning up... 04:55:51 INFO - Return code: 0 04:55:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:51 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:51 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 04:55:51 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 04:55:51 INFO - Using env: {'DISPLAY': ':0', 04:55:51 INFO - 'HOME': '/home/cltbld', 04:55:51 INFO - 'LANG': 'en_US.UTF-8', 04:55:51 INFO - 'LANGUAGE': 'en_US:en', 04:55:51 INFO - 'LOGNAME': 'cltbld', 04:55:51 INFO - 'MAIL': '/var/mail/cltbld', 04:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:51 INFO - 'MOZ_NO_REMOTE': '1', 04:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:51 INFO - 'NO_EM_RESTART': '1', 04:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:51 INFO - 'PWD': '/builds/slave/test', 04:55:51 INFO - 'SHELL': '/bin/bash', 04:55:51 INFO - 'SHLVL': '1', 04:55:51 INFO - 'TERM': 'linux', 04:55:51 INFO - 'TMOUT': '86400', 04:55:51 INFO - 'USER': 'cltbld', 04:55:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:51 INFO - '_': '/tools/buildbot/bin/python'} 04:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:55:51 INFO - Cleaning up... 04:55:51 INFO - Return code: 0 04:55:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:51 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 0x7f4de191af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', '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 04:55:51 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 04:55:51 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 04:55:51 INFO - Using env: {'DISPLAY': ':0', 04:55:51 INFO - 'HOME': '/home/cltbld', 04:55:51 INFO - 'LANG': 'en_US.UTF-8', 04:55:51 INFO - 'LANGUAGE': 'en_US:en', 04:55:51 INFO - 'LOGNAME': 'cltbld', 04:55:51 INFO - 'MAIL': '/var/mail/cltbld', 04:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:51 INFO - 'MOZ_NO_REMOTE': '1', 04:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:51 INFO - 'NO_EM_RESTART': '1', 04:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:51 INFO - 'PWD': '/builds/slave/test', 04:55:51 INFO - 'SHELL': '/bin/bash', 04:55:51 INFO - 'SHLVL': '1', 04:55:51 INFO - 'TERM': 'linux', 04:55:51 INFO - 'TMOUT': '86400', 04:55:51 INFO - 'USER': 'cltbld', 04:55:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:51 INFO - '_': '/tools/buildbot/bin/python'} 04:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:51 INFO - Downloading/unpacking flake8 04:55:51 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 04:55:51 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 04:55:51 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 04:55:51 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 04:55:51 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 04:55:51 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 04:55:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:55:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:55:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:53 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 04:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:54 INFO - no previously-included directories found matching 'docs/_build' 04:55:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:55:54 INFO - Running setup.py install for pep8 04:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:54 INFO - no previously-included directories found matching 'docs/_build' 04:55:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:55:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:55:54 INFO - Cleaning up... 04:55:54 INFO - Return code: 0 04:55:54 INFO - Running post-action listener: _resource_record_post_action 04:55:54 INFO - Running post-action listener: _start_resource_monitoring 04:55:54 INFO - Starting resource monitoring. 04:55:54 INFO - ##### 04:55:54 INFO - ##### Finished create-virtualenv step (success) 04:55:54 INFO - ##### 04:55:54 INFO - ##### 04:55:54 INFO - ##### Running install step. 04:55:54 INFO - ##### 04:55:54 INFO - Running pre-action listener: _resource_record_pre_action 04:55:54 INFO - Running main action method: install 04:55:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:54 INFO - Reading from file tmpfile_stdout 04:55:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:55:54 INFO - Reading from file tmpfile_stdout 04:55:54 INFO - Output received: 04:55:54 INFO - Usage: mozinstall [options] installer 04:55:54 INFO - Options: 04:55:54 INFO - -h, --help show this help message and exit 04:55:54 INFO - -d DEST, --destination=DEST 04:55:54 INFO - Directory to install application into. [default: 04:55:54 INFO - "/builds/slave/test"] 04:55:54 INFO - --app=APP Application being installed. [default: firefox] 04:55:54 INFO - mkdir: /builds/slave/test/build/application 04:55:54 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'] 04:55:54 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 04:56:10 INFO - Reading from file tmpfile_stdout 04:56:10 INFO - Output received: 04:56:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:56:10 INFO - Running post-action listener: _resource_record_post_action 04:56:10 INFO - ##### 04:56:10 INFO - ##### Finished install step (success) 04:56:10 INFO - ##### 04:56:10 INFO - ##### 04:56:10 INFO - ##### Running run-tests step. 04:56:10 INFO - ##### 04:56:10 INFO - Running pre-action listener: _resource_record_pre_action 04:56:10 INFO - Running main action method: run_tests 04:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:56:10 INFO - Python 2.7.3 04:56:10 INFO - Return code: 0 04:56:10 INFO - grabbing minidump binary from tooltool 04:56: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')]} 04:56:10 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 0x2c8e1c0>, '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 0x2c8f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:56:10 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 04:56:10 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 04:56:10 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 04:56:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:56:10 INFO - Return code: 0 04:56:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:56:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:56:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:56:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:56:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:56:11 INFO - Return code: 0 04:56:11 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/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 04:56:11 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/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 04:56:11 INFO - Using env: {'DISPLAY': ':0', 04:56:11 INFO - 'HOME': '/home/cltbld', 04:56:11 INFO - 'LANG': 'en_US.UTF-8', 04:56:11 INFO - 'LANGUAGE': 'en_US:en', 04:56:11 INFO - 'LOGNAME': 'cltbld', 04:56:11 INFO - 'MAIL': '/var/mail/cltbld', 04:56:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:56:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:11 INFO - 'MOZ_NO_REMOTE': '1', 04:56:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:11 INFO - 'NO_EM_RESTART': '1', 04:56:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:11 INFO - 'PWD': '/builds/slave/test', 04:56:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:56:11 INFO - 'SHELL': '/bin/bash', 04:56:11 INFO - 'SHLVL': '1', 04:56:11 INFO - 'TERM': 'linux', 04:56:11 INFO - 'TMOUT': '86400', 04:56:11 INFO - 'USER': 'cltbld', 04:56:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957', 04:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:11 INFO - '_': '/tools/buildbot/bin/python'} 04:56:11 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/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 04:56:11 INFO - mozversion application_buildid: 20160722032325 04:56:11 INFO - mozversion application_changeset: 8fd80dfc8f7df45c301780c94650e66c06ef077e 04:56:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:56:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:56:11 INFO - mozversion application_name: Firefox 04:56:11 INFO - mozversion application_remotingname: firefox-dev 04:56:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:56:11 INFO - mozversion application_vendor: Mozilla 04:56:11 INFO - mozversion application_version: 49.0a2 04:56:11 INFO - mozversion platform_buildid: 20160722032325 04:56:11 INFO - mozversion platform_changeset: 8fd80dfc8f7df45c301780c94650e66c06ef077e 04:56:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:56:11 INFO - mozversion platform_version: 49.0a2 04:56:11 INFO - using testdate: 1469188571 04:56:11 INFO - actual date: 1469188571 04:56:11 INFO - starting webserver on 'localhost:51991' 04:56:11 INFO - SUITE-START | Running 2 tests 04:56:11 INFO - TEST-START | dromaeo_css 04:56:11 INFO - operating with platform_type : linux_ 04:56:11 INFO - Initialising browser for dromaeo_css test... 04:56:11 INFO - TEST-INFO | started process 10136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkEbTck/profile http://localhost:51991/getInfo.html) 04:56:15 INFO - PROCESS | 10136 | __metrics Screen width/height:1600/1200 04:56:15 INFO - PROCESS | 10136 | colorDepth:24 04:56:15 INFO - PROCESS | 10136 | Browser inner width/height: 1024/697 04:56:15 INFO - PROCESS | 10136 | __metrics 04:56:16 INFO - PROCESS | 10136 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:16 ERROR - PROCESS | 10136 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:56:17 INFO - TEST-INFO | 10136: exit 0 04:56:17 INFO - Browser initialized. 04:56:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:56:17 INFO - TEST-INFO | started process 10226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkEbTck/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:28 INFO - PROCESS | 10226 | RSS: Main: 144887808 04:56:28 INFO - PROCESS | 10226 | 04:57:19 INFO - PROCESS | 10226 | 1469188639443 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] 04:59:27 INFO - PROCESS | 10226 | Cycle 1(1): loaded http://localhost:51991/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51991/tests/dromaeo/cssquery-ext.html) 04:59:28 INFO - PROCESS | 10226 | RSS: Main: 259706880 04:59:28 INFO - PROCESS | 10226 | 05:02:31 INFO - PROCESS | 10226 | Cycle 1(1): loaded http://localhost:51991/tests/dromaeo/cssquery-ext.html (next: http://localhost:51991/tests/dromaeo/cssquery-jquery.html) 05:02:31 INFO - PROCESS | 10226 | RSS: Main: 226562048 05:02:31 INFO - PROCESS | 10226 | 05:05:33 INFO - PROCESS | 10226 | Cycle 1(1): loaded http://localhost:51991/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51991/tests/dromaeo/cssquery-mootools.html) 05:05:34 INFO - PROCESS | 10226 | RSS: Main: 227622912 05:05:34 INFO - PROCESS | 10226 | 05:08:36 INFO - PROCESS | 10226 | Cycle 1(1): loaded http://localhost:51991/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51991/tests/dromaeo/cssquery-prototype.html) 05:08:36 INFO - PROCESS | 10226 | RSS: Main: 222789632 05:08:36 INFO - PROCESS | 10226 | 05:11:39 INFO - PROCESS | 10226 | Cycle 1(1): loaded http://localhost:51991/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51991/tests/dromaeo/cssquery-yui.html) 05:11:39 INFO - PROCESS | 10226 | RSS: Main: 216064000 05:11:39 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | Cycle 1(1): loaded http://localhost:51991/tests/dromaeo/cssquery-yui.html (next: http://localhost:51991/tests/dromaeo/cssquery-dojo.html) 05:14:42 INFO - PROCESS | 10226 | RSS: Main: 265146368 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | __start_tp_report 05:14:42 INFO - PROCESS | 10226 | _x_x_mozilla_page_load 05:14:42 INFO - PROCESS | 10226 | _x_x_mozilla_page_load_details 05:14:42 INFO - PROCESS | 10226 | |i|pagename|runs| 05:14:42 INFO - PROCESS | 10226 | |0;dojo.html;3309.4043072246996;3334.9499757503627;3337.4993750937356;3348.6818752218533;3355.077353727723;5361.51746342829;5461.15352120421;5470.398256191816;5473.972630136849;5511.035568775464;5500.532454741352;5555.333359996796;5570.749316280767;5580.190872323511;5606.046972014757;4867.8783030424165;5006.799728010884;5019.171836646967;5044.596432285409;5089.720065396402;4847.757612119398;4917.164082106051;4956.1822299320565;4973.452920178777;5067.594592432597;4948.653594248404;4970.15507363749;5001.449840517558;5068.4424713281505;5070.822521211759;5023.447420783711;5038.1687021641565;5041.269015992697;5041.924371134436;5062.26597143414;4813.446453657839;4836.758162091881;4870.512948705136;4978.87552811179;5009.699418034929;5280.287161233261;5289.68261904287;5317.9468205317835;5338.172583249602;5354.5180933715765;5841.766329346821;5857.297124345106;5876.236089308405;5885.264341957255;5891.793787217427;5851.034579294412;5923.526117910556;5934.020886553713;5940.108983652443;5940.554458415636;5327.840164795062;5389.568834493231;5468.91796623047;5470.589705772043;5535.806246781343;6004.309504407049;6004.39956004396;6024.728887200086;6046.697665116727;6052.001419765777;5580.972095139498;5806.187133801272;5820.330661973842;5822.970885145547;5828.329742079715;5761.654300741969;5826.067829147316;5849;5952.434518720715;5958.880822383528;5855.970720146372;5885.146653735184;5893.44012318829;5896.970515147483;5898.4101589840675;5654.038813401731;5657.179708942181;5903.409659034062;5915.58590898633;5916.171735956969;4500.684952053391;4502.594766471033;4508.909821803545;4513.54864513546;4514.435695538058;4001.159756451178;4010.3382941814275;4043.555208927016;4053.858114965962;4092.9386059209137;5613.971930140323;5617.522510586564;5620.662760234399;5623.184638227516;5623.887522249532;5704.600677952587;5912.822615321547;5915.467607915309;5917.940820591825;5956.940430595639;5484.067708489566;5525.861853453615;5538.778448862;5555.833325000176;5584.329880414376;4999.925001124986;5010.824621138243;5022.9748851256245;5023.372078490189;5053.797848086036;5779.653220806765;5894.970525147347;5898.616589921641;5959.404059594092;5960.970195149083;5886.23478947734;5975.432333928444;5975.581709280309;5975.820725378246;5993.61041532299;6025.18659980897;6032.819015429544;6033.9698301508215;6041.395860414099;6042.063480160582;5578.135389014709;5693.715314234189;5704.429557044263;5826.126081087871;5830.854228644318;5841.50347220491;5890.2342695449315;5896.469317761422;5897.941020589739;5924.022536281465;5729.3124825019595;5729.3984131665575;5740.655560666373;5747;5748.223989761496;5542.722863856871;5625.549956003428;5674.943250567441;5675.177099320658;5720.971395142998;5618.831435056954;5645.491905728504;5649.6327738696855;5657.858553536194;5658.009848276452;5763.193152958673;5779.768809247751;5812.041013232938;5818.0981947798155;5820.952228598723;5394.379646340721;5461.617686761889;5539.8892022160135;5590.105583106683;5619.550435965031 05:14:42 INFO - PROCESS | 10226 | |1;ext.html;604.5616927727395;643.9871202575948;646.3697894552809;661.5336187987469;673.135021497376;33541.16147096324;46457.76771116144;47432.0513589728;47441;47443;49441.25838112431;49665.751671241596;49874.50125498744;49964.50035499653;50031.49968500323;8293.543855087968;9156.130167634097;9262.768430789216;9306.302027347976;10736.355818650905;10634.78730425391;11046.834297485544;11053.834192487118;11054.889451105506;11066.778664426707;11059.668209953674;11101.666949991513;11104.222704410695;11108.389038602874;11110.222284440051;8336.499810011388;10844.511996960076;10925.945370273137;11077.612283570117;11090.778184436347;10923.508442120125;10969.561217551289;10989;11013.944930275378;11025.228234023622;45344;45556.54443455556;45625.54374456246;45637.54362456366;45657.77171114156;3845.0964023454467;4067.918641627151;4117.300058989979;4327.242732521796;4508.706934049276;35259.4711079334;35523;35570;35734.285314293826;36252.09369765777;4699.78850951708;4715.386999690053;4724.385829842098;4754.120487709784;4754.358161648168;389159;389973;390365;390632;390752;64659.67670161619;65318.673406633614;65393.673031634535;65480.34519654838;65656.67171664207;39379.803100984886;40439.393409098884;40449.79775101106;42110.57889421067;42182.57817421848;18857.811421885606;18958.71561926572;19013.71479427782;19065;19075.523111922314;11126.666200014013;13621.523246686318;13904.930475347559;13924.164550126823;14137.85862141386;21087.472813179487;21130;21207.469813254793;21247;21331;7306.378957788541;7448.888266676005;7557.662367377786;7594.202608726115;7639.541627502367;1080.4597701149426;1098.19282827122;1112.8497652816927;1162.4943149729895;1258.1696080586769;34203.82898085543;34353;34584.48123278153;34682.49685195195;34820.129496762274;1160.8548931383577;1172.1033409441784;1182.7693599747965;1201.723603571166;1242.7017515796144;17909.283628654706;17942.730859037125;18160.455186344432;18213.54466138357;18252.9087354565;588447;588500;592961;593811;597334;63839.68080159569;65378.67310663416;65752.34247657558;65794;65923.34076659172;1367.5282027700428;1433.3120102350929;1485.8737007354496;1521.7184820808186;1530.1125347298319;33130.834345828116;33823.58085585876;34533.82733086318;34814.47778283378;34857.65142348544;55461.72269138628;55899;55986.440135598124;55997;56010.439895600524;326812;327437;328074;328331;511997;30287.545686815156;31032.844835775675;31203.84398077995;32449.51325730069;32569.18577035593;52355.476445236585;52973.470265296855;53426;54306.18540721813;54386.45613543814;43753.78123109364;44167.55832441634;44370.334444982705;45149.77425112853;45555.31667024931;43148.352774707775;44012.559874400846;44260.55739442565;44352.7782361099;44644.55355446534;43505.34741978809;44351;44416;44897.775511123546;44947;37442;38671.6132838668;38849;39183.80408097941;39278.80360598179;29725.702742973157;29944.550831737106;30116;30133;30265.546016810207 05:14:42 INFO - PROCESS | 10226 | |2;jquery.html;419.37722482114077;419.57413225576045;425.3131193123106;426.571295847673;439.73176362418917;19037.61924761504;20202.898985505053;20896.89551552242;21082.789172108274;21085.051172697225;19578.706319405184;19849.801501984977;20097.397078087644;20365.694514582294;20397.184112635478;5750.769969201227;5975.641461512301;6022.789202377918;6038.728257228413;6040.57715959883;4352.477702675684;5203.219517072432;5937.821865344046;6611.3719196676475;6611.4049735523795;6541.247756508015;6664.900026499607;6671.5997040177745;6677.899831502531;6700.095487109251;6548.869022619521;6599.505037122235;6646.9667651661675;6657.101291325682;6694.899576506307;3925.685945124383;5607.243022191993;5875.559333050039;5918.585699001072;5919.260092488439;24008;24094.51810963771;24363.390915227083;24400.755992440205;24439.26682199537;2213.424509627492;2244.9663255051187;2263.649134384173;2344.2732752846673;2533.3413312538687;10642.521086551124;10682.145428365711;10736.785264294671;11049.613263535737;11090.2236843421;2021.29254760834;2055.9280425185198;2065.783092775267;2079.854410191287;2086.290661175208;66322;69070.65464672695;75104.24895751082;76483;79037;11589.304641721523;11739.530418783153;11861.46623401949;11936.462859171359;12012.519499219934;16593.41923032688;16668.41660541875;16709;16727.414540491023;16728.83271167297;8477.448965817202;8561.571921403905;8740.388172827841;8896.555172241362;8986.505742184243;8593.398462107718;8660.30717542595;8667.479951202948;8746.51894145828;8771.605277762515;5068.214426763784;5068.847934561969;5075.137226671474;5147.974260128675;5161.148410512298;2007.4780557055271;2100.149439476984;2124.458263142889;2138.6578147496325;2143.496278374581;958.3100167879115;1034.6999370182714;1064.7018834726289;1085.5115198160859;1126.814075677504;19118.2352705893;19140.330088447117;19426.611467770566;19616.21535138607;19629.214831406585;1019;1032.9380237185792;1043.0925095167102;1086.1093902999464;1091.247039542713;10531.84202236967;10795.676129716121;10982;10997.780044399067;11157.442127893573;540436;541681;546456;573143;576297;81407.59296203482;95323.52338238264;96125;99188.50405747925;101224.49387753014;1005.7385079879137;1030.1964467715343;1053.847192157133;1081.1242893256488;1083.312096818526;17645.823541764417;17682.5579360517;17866.731999019765;18083.909580452015;18356.429262004407;41167.38248926208;41238.79380603078;42368.36447453229;43571.78214108909;43846.56153438425;60255;60359.69820150871;61605.075923862074;62193;62682;7821.061472623322;8321.833563328579;8637.352198585257;8932;8990.145936136056;12985.675358116123;13352.799708004582;13414.195148291134;13474.19154850673;13499.257540835348;9826.459544725109;11318.4906679198;11718.765624687288;12099.697507562381;12208.694782630506;11480.425978700865;11713.121515886172;11774.587889423829;12031.518739250332;12049.879501204876;11016.17378696585;12026.398680066137;12115.75768484643;12233.266004039786;12469.937650311691;8320.459170153921;8385.622646981023;8435.746927592181;8552.871706924278;8669.6098675561;8902.332325075775;11109.777804444027;11120.110391168526;11287.887121128684;11365.431728413712 05:14:42 INFO - PROCESS | 10226 | |3;mootools.html;1409.0488919979011;1564.640132769463;1580.1072394097334;1799.0824679413504;1889.6882014467606;9058.592363343649;9510.096540828628;9524.142827145546;9761.316707830438;9805;9542.713718588453;9748;9750.609975600968;9754.951225243864;9761.56072976716;2128.45724340293;2366.503034362786;2481.727010028895;2496.2261698873317;2524.684414448194;2482.913098041569;2491.028498885436;2494.3390001649577;2494.538510375586;2496.9250922472356;2419.3709635494724;2469.740677228883;2474.9752502474926;2475.628655701641;2478;2091.5294058836794;2171.9782802171935;2177.640689286266;2317.9188728394593;2395.760423957599;2440.3045132137254;2474.715407728116;2482.8262021658493;2486.1298545509107;2490.4645501217324;9558.90441095587;9608.375455595364;9619.374740641835;9634.614615415376;9643.421394716339;5426.62013659044;5549.611527193058;5565.972170139164;5573.581981351374;5580.107182850765;3513.5608048993877;3585.103724068983;3644.5262115925025;3755.586885442599;3764.7176461765475;1141.1498433666889;1159.611530137405;1171.9042695080127;1191.8867707567854;1200.5257923120405;13941.512047078304;13974.441022359093;13983.79024314636;13994.230317332542;14001.71996560063;4975.303457515951;5026.597872170218;5053.418856831438;5081.898362032739;5104.4895510449405;11550.249233799776;11559.653210403701;11569.942150289195;11576.710582235512;11585.536578536765;5784.884302314014;5785.88428231433;5790.652560846363;5794.159846822187;5799.739011744482;4676.415448068991;5024.0956627807345;5147.1507201312115;5148.047611191867;5235.319408476874;4034.9798251008556;4134.1731653669385;4164;4175.645070169009;4183.393407955829;1308.4308325878083;1334.166146158651;1343.7782765843722;1344.3717532224478;1347.5822495026573;986.792773517555;1001.8196724589498;1006.7734759679014;1028.0850043461326;1034.0693375961694;6058.1518587397795;6095.689426773265;6106;6212.9068063979075;6437.645929473831;494.6463278755707;499.41568365013023;504.9444561098276;506.2254750232151;512.2700152282982;4225.345071513921;4289.1421715657;4304.139172165516;4329.675274354436;4384.320430333303;11977.880221197676;12333.136680432463;12393.318367489876;12398.380080996094;12455;11206.831897521544;11719.12106592009;11740.236884602473;12137.150399471951;12257.877421225674;8702.651893924172;8880.067592902653;8966.462012279153;9069.954650226706;9127.08729127082;6252.687365631791;6349.523785716182;6363.87272254543;6410.679466026587;6570;10492.737681558023;11288.43557822122;11326.603568875049;11342.149338799789;11456.427178640868;11026.779464410507;11208.383538905113;11220.102391808472;11261;11329.603463878724;9238.769030774285;9333.813323733622;9426.057394260519;9490.525473726424;9497.952510237405;9248.260139188984;9300.488473134043;9319.254459643076;9350.579223935076;9383.436993780395;8047.0745864226365;8094.797630059295;8225.095239523527;8329.416940814328;8333.041700204554;8314.08545060055;8409.83180336402;8413.3269338454;8496.957515212385;8537.402381833212;7331.303526165006;7355.8161045974275;7397.297256760599;7398.667059982206;7405.555666659802;5498.725063746877;5542.944570554243;5672.631278966854;5682.829515114553;5730.713464326684;5453;5521.282233309644;5671.291088613923;5699.6865172414255;5734.913976290276 05:14:42 INFO - PROCESS | 10226 | |4;prototype.html;347.6037317458097;348.26168522731814;348.86219943122467;352.5575402869402;357.71382893685046;5383.865403364918;5396.811111611094;5425.9186112208345;5504.862378440541;5505.394406615269;5374.865628359293;5421.322334708161;5429.56563474922;5441.455854414557;5442.700651464168;3911.4132880068073;4097.323941549648;4292.570742925698;4296;4298.226319262531;4241.4274073000215;4266.210751011073;4272.273713468718;4281.229378711831;4296.591823776736;4104.322786740199;4265.658747300224;4269.082147338321;4271.9359209611885;4283.121959998193;4194.517630472489;4277.572242775728;4288.463942007249;4292.819474644467;4304.461942257218;3780.092777733352;3790.4124860646643;3816.084139806454;3826.2972977025233;3826.4260360945805;5197.8440646780655;5209.869753256161;5271.156614941629;5279.762410691528;5281.52466278033;4896.36347274852;4912.263160525914;4932.136876046678;4951.341300664281;4955.1328517509655;5428.45715428458;5438.184272359138;5586.301712285965;5590.944090559124;5704.600677952545;4077.734947228421;4170.582941705805;4177.26897792885;4207.200631879933;4219.156168766228;5835.533157347444;5853.414658534155;5859.589828711949;5869.559783016291;5872.324682661506;4016.5983401660183;4223.97888010558;4232.830686772556;4233.343831706091;4233.745975241495;4254.680898932531;4256.404103425523;4256.7445953242905;4266.5946735060115;4273.230818452646;4851.175300198975;4854.927176092361;4866.05112003156;4889.755512224375;4894.19245824435;5538.335399752055;5681.659100453903;5685.545156387479;5719.28508936383;5728.971355143198;1431.5633731711928;1439.165284135199;1449.4274761469371;1452.7675571908444;1453.4404254362146;943.3113826906259;947.6067432015774;958.4584709639032;960.5725452173716;966.2511553545918;4975.477574854661;4989.501049894981;4997.525235102659;5004.173476681058;5016.573591244785;5095.8726031848755;5187.688738675616;5195.168772996378;5204.42751297357;5245.082110630625;4613.5386461354265;4952.068693209651;4957.926085826738;5006.974965125224;5013.1227035268685;2779.847108409057;2789.302674331417;2806.761425278874;2825.675047369579;2828.020385729997;5281.630285880028;5286.973565132226;5288.867778305573;5320.76056577455;5358.785648574013;5287.259783630295;5307.734613269321;5538.695371754592;5967.583128832743;5981.37195594465;5668.801591944262;5776.826695199151;5893.351731309553;5950.464458198696;5993.101034844808;5857.297124345106;5884;5895.29256489224;5895.587308888336;5911.586188966731;5597.096987024268;5757.3591526414775;5776.999999999832;5814.331351894586;5828.446297601721;5874.206982057368;5958.19564358806;5960.284765828128;5961.701914904324;5983.820485385445;4279.422277992431;4289.485261768607;4295.72077814941;4303.440552728125;4322.740635561876;5646.830595082154;5839.591228613956;5843.802020585855;5927.733252003584;5949.405059494016;5717.942820571741;5754.539636829128;5790.449907258803;5794.18881356602;5797.449242321973;5669.914951275817;5725.51333136688;5748.511376533042;5773.249477568057;5780.884382312246;5608.2148499209325;5641.238432811682;5674.77300907959;5697.772089116389;5707.800226992035;5741.684207368635;5763.250777398911;5785.334686510937;5794.362620111869;5801.216835727123;5505.9174112387545;5677.602567820213;5678.432156784289;5710.8001219957105;5713.514351280188 05:14:42 INFO - PROCESS | 10226 | |5;yui.html;779.2168870285362;830.6750732581534;860.3031544448996;891.6076926152489;913.401721872174;14567.490137845178;15856.445024424147;16099.436519721812;16108.75836862445;16113.838861611395;15253.69492610147;16012.43956461524;16051.357945682188;16060.598485037879;16093.034417934903;862.223998401439;878.2534845381439;879.65253724779;881.4755220643707;883.2801266967401;871.6121326009928;877.1141147441067;877.6226222724226;877.8946526416808;878.2841983783196;923.5336155241594;927.3323207290773;927.3740225347897;927.4620719982394;927.6104036304769;913.1735779119874;917.3486824354716;917.3807679816131;919.0166521821653;922.0594993107061;675.9493038022118;676.2730065179951;676.64814296566;676.8071099736601;676.9898451523231;15341.769873451907;15351.846481535265;15436.691266174726;15459.845401545954;15507.302171402314;14242.928785356007;14279.286035698278;14282;14333.78499322511;14359.497417590333;12287.447064882102;12369.929497293677;12431.316277604728;12458.439370228361;12521.499140034388;3123.063081075691;3136.325689976666;3156.8105913645254;3177.3645270945904;3282.868685252587;70108;72660.91008634928;78023.60988195079;78358.60820695916;78402.60798696027;12302.75394492105;12394.380280985915;12567.622971310875;12664.113512054251;12827.807582886264;22302.665460018114;22459.550808983728;22474.101035958705;22512.21207257771;22547.436314091952;9200.355975081813;9386.108319709616;9412.529373531295;9556;10003.699889003341;5013.548780609763;5108.795648174031;5224.242484839677;5352.705601191894;5377.300950876439;3768.2086761779783;3861.362875125629;3875.651191392732;3890.6692931100606;3892.143728379752;692.5913710910587;695.9860802783916;696.8780463418983;698.0750505580127;712.3837880233664;741.2476336518438;761.4936067515151;788.7278888783361;793.928546430824;819.8729196974479;10195.184385249162;10959.50682219302;11109.277896936674;11590.420478976017;11641.708957275967;744.4193529047352;817.8732296494053;824.2252282854098;842.7724514381083;852.953087580189;5106.617003724736;5343.110017463108;5378.542823860016;5410.810621628224;5461.317335333083;70914;72103.63948180225;101123.49438252761;117763.41118294524;126623;100255.49872250739;102001.46997795039;102944.48527757313;104981;105301;90071;90860;91531;92620.53689731508;92919.99999999865;10023.849642255225;10164.390136591828;10211.795764084825;10306.12397946183;10392.844107338246;54138.18792718191;54932.17601735897;56050.43949560452;57166.7141664289;57549.4245057544;69052.30947690459;69237.30762692308;69476;70156.64921675359;71468.28531714824;13675.931620341835;14058.718825623226;14069.226192559097;14371.856281437053;14457.349419276368;15572.532824015298;15749.44876929302;15910.204489775697;16008.03951762898;16364.590885227964;14816;15182.953034891525;15453.459128930434;15845.286962086504;15959.521214363587;14828.555143345717;15479.380824766884;15638.84361156374;15895.046297222203;15926.124063176174;13971.790423143864;14434.422623094959;15050.548483545512;15198.392064317304;15414.46049388266;10869.239153259196;11034.448277586249;11484.655460336204;11574.421278935852;11679.649610511698;10527.947360263455;11255.540614572634;11264.887351126385;11287;11398.316101033965 05:14:42 INFO - PROCESS | 10226 | __end_tp_report 05:14:42 INFO - PROCESS | 10226 | __start_cc_report 05:14:42 INFO - PROCESS | 10226 | _x_x_mozilla_cycle_collect,959 05:14:42 INFO - PROCESS | 10226 | __end_cc_report 05:14:42 INFO - PROCESS | 10226 | __startTimestamp1469189682639__endTimestamp 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | ------- Summary: start ------- 05:14:42 INFO - PROCESS | 10226 | Number of tests: 6 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | [#0] dojo.html Cycles:165 Average:5443.90 Median:5623.18 stddev:596.43 (10.6%) stddev-sans-first:574.27 05:14:42 INFO - PROCESS | 10226 | Values: 3309.4 3334.9 3337.5 3348.7 3355.1 5361.5 5461.2 5470.4 5474.0 5511.0 5500.5 5555.3 5570.7 5580.2 5606.0 4867.9 5006.8 5019.2 5044.6 5089.7 4847.8 4917.2 4956.2 4973.5 5067.6 4948.7 4970.2 5001.4 5068.4 5070.8 5023.4 5038.2 5041.3 5041.9 5062.3 4813.4 4836.8 4870.5 4978.9 5009.7 5280.3 5289.7 5317.9 5338.2 5354.5 5841.8 5857.3 5876.2 5885.3 5891.8 5851.0 5923.5 5934.0 5940.1 5940.6 5327.8 5389.6 5468.9 5470.6 5535.8 6004.3 6004.4 6024.7 6046.7 6052.0 5581.0 5806.2 5820.3 5823.0 5828.3 5761.7 5826.1 5849.0 5952.4 5958.9 5856.0 5885.1 5893.4 5897.0 5898.4 5654.0 5657.2 5903.4 5915.6 5916.2 4500.7 4502.6 4508.9 4513.5 4514.4 4001.2 4010.3 4043.6 4053.9 4092.9 5614.0 5617.5 5620.7 5623.2 5623.9 5704.6 5912.8 5915.5 5917.9 5956.9 5484.1 5525.9 5538.8 5555.8 5584.3 4999.9 5010.8 5023.0 5023.4 5053.8 5779.7 5895.0 5898.6 5959.4 5961.0 5886.2 5975.4 5975.6 5975.8 5993.6 6025.2 6032.8 6034.0 6041.4 6042.1 5578.1 5693.7 5704.4 5826.1 5830.9 5841.5 5890.2 5896.5 5897.9 5924.0 5729.3 5729.4 5740.7 5747.0 5748.2 5542.7 5625.5 5674.9 5675.2 5721.0 5618.8 5645.5 5649.6 5657.9 5658.0 5763.2 5779.8 5812.0 5818.1 5821.0 5394.4 5461.6 5539.9 5590.1 5619.6 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | [#1] ext.html Cycles:180 Average:62521.40 Median:390169.00 stddev:122615.05 (31.4%) stddev-sans-first:122870.89 05:14:42 INFO - PROCESS | 10226 | Values: 604.6 644.0 646.4 661.5 673.1 33541.2 46457.8 47432.1 47441.0 47443.0 49441.3 49665.8 49874.5 49964.5 50031.5 8293.5 9156.1 9262.8 9306.3 10736.4 10634.8 11046.8 11053.8 11054.9 11066.8 11059.7 11101.7 11104.2 11108.4 11110.2 8336.5 10844.5 10925.9 11077.6 11090.8 10923.5 10969.6 10989.0 11013.9 11025.2 45344.0 45556.5 45625.5 45637.5 45657.8 3845.1 4067.9 4117.3 4327.2 4508.7 35259.5 35523.0 35570.0 35734.3 36252.1 4699.8 4715.4 4724.4 4754.1 4754.4 389159.0 389973.0 390365.0 390632.0 390752.0 64659.7 65318.7 65393.7 65480.3 65656.7 39379.8 40439.4 40449.8 42110.6 42182.6 18857.8 18958.7 19013.7 19065.0 19075.5 11126.7 13621.5 13904.9 13924.2 14137.9 21087.5 21130.0 21207.5 21247.0 21331.0 7306.4 7448.9 7557.7 7594.2 7639.5 1080.5 1098.2 1112.8 1162.5 1258.2 34203.8 34353.0 34584.5 34682.5 34820.1 1160.9 1172.1 1182.8 1201.7 1242.7 17909.3 17942.7 18160.5 18213.5 18252.9 588447.0 588500.0 592961.0 593811.0 597334.0 63839.7 65378.7 65752.3 65794.0 65923.3 1367.5 1433.3 1485.9 1521.7 1530.1 33130.8 33823.6 34533.8 34814.5 34857.7 55461.7 55899.0 55986.4 55997.0 56010.4 326812.0 327437.0 328074.0 328331.0 511997.0 30287.5 31032.8 31203.8 32449.5 32569.2 52355.5 52973.5 53426.0 54306.2 54386.5 43753.8 44167.6 44370.3 45149.8 45555.3 43148.4 44012.6 44260.6 44352.8 44644.6 43505.3 44351.0 44416.0 44897.8 44947.0 37442.0 38671.6 38849.0 39183.8 39278.8 29725.7 29944.6 30116.0 30133.0 30265.5 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | [#2] jquery.html Cycles:180 Average:31083.97 Median:2303.96 stddev:91254.98 (3960.8%) stddev-sans-first:91481.93 05:14:42 INFO - PROCESS | 10226 | Values: 419.4 419.6 425.3 426.6 439.7 19037.6 20202.9 20896.9 21082.8 21085.1 19578.7 19849.8 20097.4 20365.7 20397.2 5750.8 5975.6 6022.8 6038.7 6040.6 4352.5 5203.2 5937.8 6611.4 6611.4 6541.2 6664.9 6671.6 6677.9 6700.1 6548.9 6599.5 6647.0 6657.1 6694.9 3925.7 5607.2 5875.6 5918.6 5919.3 24008.0 24094.5 24363.4 24400.8 24439.3 2213.4 2245.0 2263.6 2344.3 2533.3 10642.5 10682.1 10736.8 11049.6 11090.2 2021.3 2055.9 2065.8 2079.9 2086.3 66322.0 69070.7 75104.2 76483.0 79037.0 11589.3 11739.5 11861.5 11936.5 12012.5 16593.4 16668.4 16709.0 16727.4 16728.8 8477.4 8561.6 8740.4 8896.6 8986.5 8593.4 8660.3 8667.5 8746.5 8771.6 5068.2 5068.8 5075.1 5148.0 5161.1 2007.5 2100.1 2124.5 2138.7 2143.5 958.3 1034.7 1064.7 1085.5 1126.8 19118.2 19140.3 19426.6 19616.2 19629.2 1019.0 1032.9 1043.1 1086.1 1091.2 10531.8 10795.7 10982.0 10997.8 11157.4 540436.0 541681.0 546456.0 573143.0 576297.0 81407.6 95323.5 96125.0 99188.5 101224.5 1005.7 1030.2 1053.8 1081.1 1083.3 17645.8 17682.6 17866.7 18083.9 18356.4 41167.4 41238.8 42368.4 43571.8 43846.6 60255.0 60359.7 61605.1 62193.0 62682.0 7821.1 8321.8 8637.4 8932.0 8990.1 12985.7 13352.8 13414.2 13474.2 13499.3 9826.5 11318.5 11718.8 12099.7 12208.7 11480.4 11713.1 11774.6 12031.5 12049.9 11016.2 12026.4 12115.8 12233.3 12469.9 8320.5 8385.6 8435.7 8552.9 8669.6 8902.3 11109.8 11120.1 11287.9 11365.4 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | [#3] mootools.html Cycles:180 Average:6324.21 Median:2734.97 stddev:3738.06 (136.7%) stddev-sans-first:3730.29 05:14:42 INFO - PROCESS | 10226 | Values: 1409.0 1564.6 1580.1 1799.1 1889.7 9058.6 9510.1 9524.1 9761.3 9805.0 9542.7 9748.0 9750.6 9755.0 9761.6 2128.5 2366.5 2481.7 2496.2 2524.7 2482.9 2491.0 2494.3 2494.5 2496.9 2419.4 2469.7 2475.0 2475.6 2478.0 2091.5 2172.0 2177.6 2317.9 2395.8 2440.3 2474.7 2482.8 2486.1 2490.5 9558.9 9608.4 9619.4 9634.6 9643.4 5426.6 5549.6 5566.0 5573.6 5580.1 3513.6 3585.1 3644.5 3755.6 3764.7 1141.1 1159.6 1171.9 1191.9 1200.5 13941.5 13974.4 13983.8 13994.2 14001.7 4975.3 5026.6 5053.4 5081.9 5104.5 11550.2 11559.7 11569.9 11576.7 11585.5 5784.9 5785.9 5790.7 5794.2 5799.7 4676.4 5024.1 5147.2 5148.0 5235.3 4035.0 4134.2 4164.0 4175.6 4183.4 1308.4 1334.2 1343.8 1344.4 1347.6 986.8 1001.8 1006.8 1028.1 1034.1 6058.2 6095.7 6106.0 6212.9 6437.6 494.6 499.4 504.9 506.2 512.3 4225.3 4289.1 4304.1 4329.7 4384.3 11977.9 12333.1 12393.3 12398.4 12455.0 11206.8 11719.1 11740.2 12137.2 12257.9 8702.7 8880.1 8966.5 9070.0 9127.1 6252.7 6349.5 6363.9 6410.7 6570.0 10492.7 11288.4 11326.6 11342.1 11456.4 11026.8 11208.4 11220.1 11261.0 11329.6 9238.8 9333.8 9426.1 9490.5 9498.0 9248.3 9300.5 9319.3 9350.6 9383.4 8047.1 8094.8 8225.1 8329.4 8333.0 8314.1 8409.8 8413.3 8497.0 8537.4 7331.3 7355.8 7397.3 7398.7 7405.6 5498.7 5542.9 5672.6 5682.8 5730.7 5453.0 5521.3 5671.3 5699.7 5734.9 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | [#4] prototype.html Cycles:180 Average:4726.45 Median:5284.30 stddev:1376.79 (26.1%) stddev-sans-first:1340.84 05:14:42 INFO - PROCESS | 10226 | Values: 347.6 348.3 348.9 352.6 357.7 5383.9 5396.8 5425.9 5504.9 5505.4 5374.9 5421.3 5429.6 5441.5 5442.7 3911.4 4097.3 4292.6 4296.0 4298.2 4241.4 4266.2 4272.3 4281.2 4296.6 4104.3 4265.7 4269.1 4271.9 4283.1 4194.5 4277.6 4288.5 4292.8 4304.5 3780.1 3790.4 3816.1 3826.3 3826.4 5197.8 5209.9 5271.2 5279.8 5281.5 4896.4 4912.3 4932.1 4951.3 4955.1 5428.5 5438.2 5586.3 5590.9 5704.6 4077.7 4170.6 4177.3 4207.2 4219.2 5835.5 5853.4 5859.6 5869.6 5872.3 4016.6 4224.0 4232.8 4233.3 4233.7 4254.7 4256.4 4256.7 4266.6 4273.2 4851.2 4854.9 4866.1 4889.8 4894.2 5538.3 5681.7 5685.5 5719.3 5729.0 1431.6 1439.2 1449.4 1452.8 1453.4 943.3 947.6 958.5 960.6 966.3 4975.5 4989.5 4997.5 5004.2 5016.6 5095.9 5187.7 5195.2 5204.4 5245.1 4613.5 4952.1 4957.9 5007.0 5013.1 2779.8 2789.3 2806.8 2825.7 2828.0 5281.6 5287.0 5288.9 5320.8 5358.8 5287.3 5307.7 5538.7 5967.6 5981.4 5668.8 5776.8 5893.4 5950.5 5993.1 5857.3 5884.0 5895.3 5895.6 5911.6 5597.1 5757.4 5777.0 5814.3 5828.4 5874.2 5958.2 5960.3 5961.7 5983.8 4279.4 4289.5 4295.7 4303.4 4322.7 5646.8 5839.6 5843.8 5927.7 5949.4 5717.9 5754.5 5790.4 5794.2 5797.4 5669.9 5725.5 5748.5 5773.2 5780.9 5608.2 5641.2 5674.8 5697.8 5707.8 5741.7 5763.3 5785.3 5794.4 5801.2 5505.9 5677.6 5678.4 5710.8 5713.5 05:14:42 INFO - PROCESS | 10226 | 05:14:42 INFO - PROCESS | 10226 | [#5] yui.html Cycles:180 Average:21020.35 Median:3146.57 stddev:29184.32 (927.5%) stddev-sans-first:29226.61 05:14:42 INFO - PROCESS | 10226 | Values: 779.2 830.7 860.3 891.6 913.4 14567.5 15856.4 16099.4 16108.8 16113.8 15253.7 16012.4 16051.4 16060.6 16093.0 862.2 878.3 879.7 881.5 883.3 871.6 877.1 877.6 877.9 878.3 923.5 927.3 927.4 927.5 927.6 913.2 917.3 917.4 919.0 922.1 675.9 676.3 676.6 676.8 677.0 15341.8 15351.8 15436.7 15459.8 15507.3 14242.9 14279.3 14282.0 14333.8 14359.5 12287.4 12369.9 12431.3 12458.4 12521.5 3123.1 3136.3 3156.8 3177.4 3282.9 70108.0 72660.9 78023.6 78358.6 78402.6 12302.8 12394.4 12567.6 12664.1 12827.8 22302.7 22459.6 22474.1 22512.2 22547.4 9200.4 9386.1 9412.5 9556.0 10003.7 5013.5 5108.8 5224.2 5352.7 5377.3 3768.2 3861.4 3875.7 3890.7 3892.1 692.6 696.0 696.9 698.1 712.4 741.2 761.5 788.7 793.9 819.9 10195.2 10959.5 11109.3 11590.4 11641.7 744.4 817.9 824.2 842.8 853.0 5106.6 5343.1 5378.5 5410.8 5461.3 70914.0 72103.6 101123.5 117763.4 126623.0 100255.5 102001.5 102944.5 104981.0 105301.0 90071.0 90860.0 91531.0 92620.5 92920.0 10023.8 10164.4 10211.8 10306.1 10392.8 54138.2 54932.2 56050.4 57166.7 57549.4 69052.3 69237.3 69476.0 70156.6 71468.3 13675.9 14058.7 14069.2 14371.9 14457.3 15572.5 15749.4 15910.2 16008.0 16364.6 14816.0 15183.0 15453.5 15845.3 15959.5 14828.6 15479.4 15638.8 15895.0 15926.1 13971.8 14434.4 15050.5 15198.4 15414.5 10869.2 11034.4 11484.7 11574.4 11679.6 10527.9 11255.5 11264.9 11287.0 11398.3 05:14:42 INFO - PROCESS | 10226 | -------- Summary: end -------- 05:14:42 INFO - PROCESS | 10226 | 05:14:43 INFO - TEST-INFO | 10226: exit 0 05:14:43 INFO - TEST-OK | dromaeo_css | took 1111618ms 05:14:43 INFO - TEST-START | kraken 05:14:43 INFO - operating with platform_type : linux_ 05:14:43 INFO - Initialising browser for kraken test... 05:14:43 INFO - TEST-INFO | started process 10418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywWxZK/profile http://localhost:51991/getInfo.html) 05:14:46 INFO - PROCESS | 10418 | __metrics Screen width/height:1600/1200 05:14:46 INFO - PROCESS | 10418 | colorDepth:24 05:14:46 INFO - PROCESS | 10418 | Browser inner width/height: 1024/697 05:14:46 INFO - PROCESS | 10418 | __metrics 05:14:47 INFO - PROCESS | 10418 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:14:47 ERROR - PROCESS | 10418 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:14:48 INFO - TEST-INFO | 10418: exit 0 05:14:48 INFO - Browser initialized. 05:14:48 INFO - Running cycle 1/1 for kraken test... 05:14:48 INFO - TEST-INFO | started process 10511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywWxZK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:00 INFO - PROCESS | 10511 | RSS: Main: 144633856 05:15:00 INFO - PROCESS | 10511 | 05:15:02 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51991/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:03 INFO - PROCESS | 10511 | RSS: Main: 194113536 05:15:03 INFO - PROCESS | 10511 | 05:15:06 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51991/tests/kraken/driver.html?testName=audio-dft) 05:15:06 INFO - PROCESS | 10511 | RSS: Main: 192159744 05:15:06 INFO - PROCESS | 10511 | 05:15:09 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51991/tests/kraken/driver.html?testName=audio-fft) 05:15:10 INFO - PROCESS | 10511 | RSS: Main: 278949888 05:15:10 INFO - PROCESS | 10511 | 05:15:12 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51991/tests/kraken/driver.html?testName=audio-oscillator) 05:15:12 INFO - PROCESS | 10511 | RSS: Main: 187613184 05:15:12 INFO - PROCESS | 10511 | 05:15:14 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51991/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:15:15 INFO - PROCESS | 10511 | RSS: Main: 187953152 05:15:15 INFO - PROCESS | 10511 | 05:15:18 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51991/tests/kraken/driver.html?testName=imaging-darkroom) 05:15:19 INFO - PROCESS | 10511 | RSS: Main: 223232000 05:15:19 INFO - PROCESS | 10511 | 05:15:22 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51991/tests/kraken/driver.html?testName=imaging-desaturate) 05:15:23 INFO - PROCESS | 10511 | RSS: Main: 222416896 05:15:23 INFO - PROCESS | 10511 | 05:15:25 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51991/tests/kraken/driver.html?testName=json-parse-financial) 05:15:26 INFO - PROCESS | 10511 | RSS: Main: 222683136 05:15:26 INFO - PROCESS | 10511 | 05:15:27 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51991/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:28 INFO - PROCESS | 10511 | RSS: Main: 201015296 05:15:28 INFO - PROCESS | 10511 | 05:15:30 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:30 INFO - PROCESS | 10511 | RSS: Main: 201883648 05:15:30 INFO - PROCESS | 10511 | 05:15:32 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:33 INFO - PROCESS | 10511 | RSS: Main: 209051648 05:15:33 INFO - PROCESS | 10511 | 05:15:35 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:36 INFO - PROCESS | 10511 | RSS: Main: 215031808 05:15:36 INFO - PROCESS | 10511 | 05:15:39 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:15:39 INFO - PROCESS | 10511 | RSS: Main: 213790720 05:15:39 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | Cycle 1(1): loaded http://localhost:51991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51991/tests/kraken/driver.html?testName=ai-astar) 05:15:41 INFO - PROCESS | 10511 | RSS: Main: 256413696 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | __start_tp_report 05:15:41 INFO - PROCESS | 10511 | _x_x_mozilla_page_load 05:15:41 INFO - PROCESS | 10511 | _x_x_mozilla_page_load_details 05:15:41 INFO - PROCESS | 10511 | |i|pagename|runs| 05:15:41 INFO - PROCESS | 10511 | |0;ai-astar;113;106;111;111;111;110;110;113;110;109 05:15:41 INFO - PROCESS | 10511 | |1;audio-beat-detection;154;122;125;180;124;134;152;132;160;123 05:15:41 INFO - PROCESS | 10511 | |2;audio-dft;159;161;159;160;160;160;159;160;159;161 05:15:41 INFO - PROCESS | 10511 | |3;audio-fft;74;74;75;106;75;75;76;74;108;76 05:15:41 INFO - PROCESS | 10511 | |4;audio-oscillator;82;84;113;84;83;85;127;84;85;121 05:15:41 INFO - PROCESS | 10511 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;116 05:15:41 INFO - PROCESS | 10511 | |6;imaging-darkroom;147;146;146;147;147;147;145;145;147;148 05:15:41 INFO - PROCESS | 10511 | |7;imaging-desaturate;94;95;95;95;94;96;96;96;96;95 05:15:41 INFO - PROCESS | 10511 | |8;json-parse-financial;52;49;50;52;53;52;52;56;51;51 05:15:41 INFO - PROCESS | 10511 | |9;json-stringify-tinderbox;59;63;59;58;58;60;58;59;59;59 05:15:41 INFO - PROCESS | 10511 | |10;stanford-crypto-aes;79;81;80;76;76;77;76;77;105;77 05:15:41 INFO - PROCESS | 10511 | |11;stanford-crypto-ccm;121;118;118;119;118;117;118;120;130;119 05:15:41 INFO - PROCESS | 10511 | |12;stanford-crypto-pbkdf2;154;152;156;151;159;157;153;150;155;156 05:15:41 INFO - PROCESS | 10511 | |13;stanford-crypto-sha256-iterative;62;62;63;60;61;62;59;59;61;59 05:15:41 INFO - PROCESS | 10511 | __end_tp_report 05:15:41 INFO - PROCESS | 10511 | __start_cc_report 05:15:41 INFO - PROCESS | 10511 | _x_x_mozilla_cycle_collect,1587 05:15:41 INFO - PROCESS | 10511 | __end_cc_report 05:15:41 INFO - PROCESS | 10511 | __startTimestamp1469189741684__endTimestamp 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | ------- Summary: start ------- 05:15:41 INFO - PROCESS | 10511 | Number of tests: 14 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.01 (1.8%) stddev-sans-first:1.90 05:15:41 INFO - PROCESS | 10511 | Values: 113.0 106.0 111.0 111.0 111.0 110.0 110.0 113.0 110.0 109.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:143.00 stddev:19.81 (13.9%) stddev-sans-first:20.40 05:15:41 INFO - PROCESS | 10511 | Values: 154.0 122.0 125.0 180.0 124.0 134.0 152.0 132.0 160.0 123.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 05:15:41 INFO - PROCESS | 10511 | Values: 159.0 161.0 159.0 160.0 160.0 160.0 159.0 160.0 159.0 161.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:13.57 (18.1%) stddev-sans-first:14.14 05:15:41 INFO - PROCESS | 10511 | Values: 74.0 74.0 75.0 106.0 75.0 75.0 76.0 74.0 108.0 76.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:17.95 (21.4%) stddev-sans-first:18.43 05:15:41 INFO - PROCESS | 10511 | Values: 82.0 84.0 113.0 84.0 83.0 85.0 127.0 84.0 85.0 121.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:15:41 INFO - PROCESS | 10511 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 05:15:41 INFO - PROCESS | 10511 | Values: 147.0 146.0 146.0 147.0 147.0 147.0 145.0 145.0 147.0 148.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 05:15:41 INFO - PROCESS | 10511 | Values: 94.0 95.0 95.0 95.0 94.0 96.0 96.0 96.0 96.0 95.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.87 (3.6%) stddev-sans-first:1.99 05:15:41 INFO - PROCESS | 10511 | Values: 52.0 49.0 50.0 52.0 53.0 52.0 52.0 56.0 51.0 51.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:1.48 (2.5%) stddev-sans-first:1.56 05:15:41 INFO - PROCESS | 10511 | Values: 59.0 63.0 59.0 58.0 58.0 60.0 58.0 59.0 59.0 59.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:77.00 stddev:8.82 (11.5%) stddev-sans-first:9.34 05:15:41 INFO - PROCESS | 10511 | Values: 79.0 81.0 80.0 76.0 76.0 77.0 76.0 77.0 105.0 77.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:119.00 stddev:3.77 (3.2%) stddev-sans-first:3.97 05:15:41 INFO - PROCESS | 10511 | Values: 121.0 118.0 118.0 119.0 118.0 117.0 118.0 120.0 130.0 119.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:155.50 stddev:2.83 (1.8%) stddev-sans-first:3.00 05:15:41 INFO - PROCESS | 10511 | Values: 154.0 152.0 156.0 151.0 159.0 157.0 153.0 150.0 155.0 156.0 05:15:41 INFO - PROCESS | 10511 | 05:15:41 INFO - PROCESS | 10511 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:61.50 stddev:1.48 (2.4%) stddev-sans-first:1.50 05:15:41 INFO - PROCESS | 10511 | Values: 62.0 62.0 63.0 60.0 61.0 62.0 59.0 59.0 61.0 59.0 05:15:41 INFO - PROCESS | 10511 | -------- Summary: end -------- 05:15:41 INFO - PROCESS | 10511 | 05:15:42 INFO - TEST-INFO | 10511: exit 0 05:15:42 INFO - TEST-OK | kraken | took 59277ms 05:15:42 INFO - SUITE-END | took 1170s 05:15:42 INFO - Completed test suite (00:19:31) 05:15:42 INFO - javascript benchmark 05:15:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.4043072246996, 3334.9499757503627, 3337.4993750937356, 3348.6818752218533, 3355.077353727723, 5361.51746342829, 5461.15352120421, 5470.398256191816, 5473.972630136849, 5511.035568775464, 5500.532454741352, 5555.333359996796, 5570.749316280767, 5580.190872323511, 5606.046972014757, 4867.8783030424165, 5006.799728010884, 5019.171836646967, 5044.596432285409, 5089.720065396402, 4847.757612119398, 4917.164082106051, 4956.1822299320565, 4973.452920178777, 5067.594592432597, 4948.653594248404, 4970.15507363749, 5001.449840517558, 5068.4424713281505, 5070.822521211759, 5023.447420783711, 5038.1687021641565, 5041.269015992697, 5041.924371134436, 5062.26597143414, 4813.446453657839, 4836.758162091881, 4870.512948705136, 4978.87552811179, 5009.699418034929, 5280.287161233261, 5289.68261904287, 5317.9468205317835, 5338.172583249602, 5354.5180933715765, 5841.766329346821, 5857.297124345106, 5876.236089308405, 5885.264341957255, 5891.793787217427, 5851.034579294412, 5923.526117910556, 5934.020886553713, 5940.108983652443, 5940.554458415636, 5327.840164795062, 5389.568834493231, 5468.91796623047, 5470.589705772043, 5535.806246781343, 6004.309504407049, 6004.39956004396, 6024.728887200086, 6046.697665116727, 6052.001419765777, 5580.972095139498, 5806.187133801272, 5820.330661973842, 5822.970885145547, 5828.329742079715, 5761.654300741969, 5826.067829147316, 5849.0, 5952.434518720715, 5958.880822383528, 5855.970720146372, 5885.146653735184, 5893.44012318829, 5896.970515147483, 5898.4101589840675, 5654.038813401731, 5657.179708942181, 5903.409659034062, 5915.58590898633, 5916.171735956969, 4500.684952053391, 4502.594766471033, 4508.909821803545, 4513.54864513546, 4514.435695538058, 4001.159756451178, 4010.3382941814275, 4043.555208927016, 4053.858114965962, 4092.9386059209137, 5613.971930140323, 5617.522510586564, 5620.662760234399, 5623.184638227516, 5623.887522249532, 5704.600677952587, 5912.822615321547, 5915.467607915309, 5917.940820591825, 5956.940430595639, 5484.067708489566, 5525.861853453615, 5538.778448862, 5555.833325000176, 5584.329880414376, 4999.925001124986, 5010.824621138243, 5022.9748851256245, 5023.372078490189, 5053.797848086036, 5779.653220806765, 5894.970525147347, 5898.616589921641, 5959.404059594092, 5960.970195149083, 5886.23478947734, 5975.432333928444, 5975.581709280309, 5975.820725378246, 5993.61041532299, 6025.18659980897, 6032.819015429544, 6033.9698301508215, 6041.395860414099, 6042.063480160582, 5578.135389014709, 5693.715314234189, 5704.429557044263, 5826.126081087871, 5830.854228644318, 5841.50347220491, 5890.2342695449315, 5896.469317761422, 5897.941020589739, 5924.022536281465, 5729.3124825019595, 5729.3984131665575, 5740.655560666373, 5747.0, 5748.223989761496, 5542.722863856871, 5625.549956003428, 5674.943250567441, 5675.177099320658, 5720.971395142998, 5618.831435056954, 5645.491905728504, 5649.6327738696855, 5657.858553536194, 5658.009848276452, 5763.193152958673, 5779.768809247751, 5812.041013232938, 5818.0981947798155, 5820.952228598723, 5394.379646340721, 5461.617686761889, 5539.8892022160135, 5590.105583106683, 5619.550435965031], "value": 5406.039683412764, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.5616927727395, 643.9871202575948, 646.3697894552809, 661.5336187987469, 673.135021497376, 33541.16147096324, 46457.76771116144, 47432.0513589728, 47441.0, 47443.0, 49441.25838112431, 49665.751671241596, 49874.50125498744, 49964.50035499653, 50031.49968500323, 8293.543855087968, 9156.130167634097, 9262.768430789216, 9306.302027347976, 10736.355818650905, 10634.78730425391, 11046.834297485544, 11053.834192487118, 11054.889451105506, 11066.778664426707, 11059.668209953674, 11101.666949991513, 11104.222704410695, 11108.389038602874, 11110.222284440051, 8336.499810011388, 10844.511996960076, 10925.945370273137, 11077.612283570117, 11090.778184436347, 10923.508442120125, 10969.561217551289, 10989.0, 11013.944930275378, 11025.228234023622, 45344.0, 45556.54443455556, 45625.54374456246, 45637.54362456366, 45657.77171114156, 3845.0964023454467, 4067.918641627151, 4117.300058989979, 4327.242732521796, 4508.706934049276, 35259.4711079334, 35523.0, 35570.0, 35734.285314293826, 36252.09369765777, 4699.78850951708, 4715.386999690053, 4724.385829842098, 4754.120487709784, 4754.358161648168, 389159.0, 389973.0, 390365.0, 390632.0, 390752.0, 64659.67670161619, 65318.673406633614, 65393.673031634535, 65480.34519654838, 65656.67171664207, 39379.803100984886, 40439.393409098884, 40449.79775101106, 42110.57889421067, 42182.57817421848, 18857.811421885606, 18958.71561926572, 19013.71479427782, 19065.0, 19075.523111922314, 11126.666200014013, 13621.523246686318, 13904.930475347559, 13924.164550126823, 14137.85862141386, 21087.472813179487, 21130.0, 21207.469813254793, 21247.0, 21331.0, 7306.378957788541, 7448.888266676005, 7557.662367377786, 7594.202608726115, 7639.541627502367, 1080.4597701149426, 1098.19282827122, 1112.8497652816927, 1162.4943149729895, 1258.1696080586769, 34203.82898085543, 34353.0, 34584.48123278153, 34682.49685195195, 34820.129496762274, 1160.8548931383577, 1172.1033409441784, 1182.7693599747965, 1201.723603571166, 1242.7017515796144, 17909.283628654706, 17942.730859037125, 18160.455186344432, 18213.54466138357, 18252.9087354565, 588447.0, 588500.0, 592961.0, 593811.0, 597334.0, 63839.68080159569, 65378.67310663416, 65752.34247657558, 65794.0, 65923.34076659172, 1367.5282027700428, 1433.3120102350929, 1485.8737007354496, 1521.7184820808186, 1530.1125347298319, 33130.834345828116, 33823.58085585876, 34533.82733086318, 34814.47778283378, 34857.65142348544, 55461.72269138628, 55899.0, 55986.440135598124, 55997.0, 56010.439895600524, 326812.0, 327437.0, 328074.0, 328331.0, 511997.0, 30287.545686815156, 31032.844835775675, 31203.84398077995, 32449.51325730069, 32569.18577035593, 52355.476445236585, 52973.470265296855, 53426.0, 54306.18540721813, 54386.45613543814, 43753.78123109364, 44167.55832441634, 44370.334444982705, 45149.77425112853, 45555.31667024931, 43148.352774707775, 44012.559874400846, 44260.55739442565, 44352.7782361099, 44644.55355446534, 43505.34741978809, 44351.0, 44416.0, 44897.775511123546, 44947.0, 37442.0, 38671.6132838668, 38849.0, 39183.80408097941, 39278.80360598179, 29725.702742973157, 29944.550831737106, 30116.0, 30133.0, 30265.546016810207], "value": 21771.812440118443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.37722482114077, 419.57413225576045, 425.3131193123106, 426.571295847673, 439.73176362418917, 19037.61924761504, 20202.898985505053, 20896.89551552242, 21082.789172108274, 21085.051172697225, 19578.706319405184, 19849.801501984977, 20097.397078087644, 20365.694514582294, 20397.184112635478, 5750.769969201227, 5975.641461512301, 6022.789202377918, 6038.728257228413, 6040.57715959883, 4352.477702675684, 5203.219517072432, 5937.821865344046, 6611.3719196676475, 6611.4049735523795, 6541.247756508015, 6664.900026499607, 6671.5997040177745, 6677.899831502531, 6700.095487109251, 6548.869022619521, 6599.505037122235, 6646.9667651661675, 6657.101291325682, 6694.899576506307, 3925.685945124383, 5607.243022191993, 5875.559333050039, 5918.585699001072, 5919.260092488439, 24008.0, 24094.51810963771, 24363.390915227083, 24400.755992440205, 24439.26682199537, 2213.424509627492, 2244.9663255051187, 2263.649134384173, 2344.2732752846673, 2533.3413312538687, 10642.521086551124, 10682.145428365711, 10736.785264294671, 11049.613263535737, 11090.2236843421, 2021.29254760834, 2055.9280425185198, 2065.783092775267, 2079.854410191287, 2086.290661175208, 66322.0, 69070.65464672695, 75104.24895751082, 76483.0, 79037.0, 11589.304641721523, 11739.530418783153, 11861.46623401949, 11936.462859171359, 12012.519499219934, 16593.41923032688, 16668.41660541875, 16709.0, 16727.414540491023, 16728.83271167297, 8477.448965817202, 8561.571921403905, 8740.388172827841, 8896.555172241362, 8986.505742184243, 8593.398462107718, 8660.30717542595, 8667.479951202948, 8746.51894145828, 8771.605277762515, 5068.214426763784, 5068.847934561969, 5075.137226671474, 5147.974260128675, 5161.148410512298, 2007.4780557055271, 2100.149439476984, 2124.458263142889, 2138.6578147496325, 2143.496278374581, 958.3100167879115, 1034.6999370182714, 1064.7018834726289, 1085.5115198160859, 1126.814075677504, 19118.2352705893, 19140.330088447117, 19426.611467770566, 19616.21535138607, 19629.214831406585, 1019.0, 1032.9380237185792, 1043.0925095167102, 1086.1093902999464, 1091.247039542713, 10531.84202236967, 10795.676129716121, 10982.0, 10997.780044399067, 11157.442127893573, 540436.0, 541681.0, 546456.0, 573143.0, 576297.0, 81407.59296203482, 95323.52338238264, 96125.0, 99188.50405747925, 101224.49387753014, 1005.7385079879137, 1030.1964467715343, 1053.847192157133, 1081.1242893256488, 1083.312096818526, 17645.823541764417, 17682.5579360517, 17866.731999019765, 18083.909580452015, 18356.429262004407, 41167.38248926208, 41238.79380603078, 42368.36447453229, 43571.78214108909, 43846.56153438425, 60255.0, 60359.69820150871, 61605.075923862074, 62193.0, 62682.0, 7821.061472623322, 8321.833563328579, 8637.352198585257, 8932.0, 8990.145936136056, 12985.675358116123, 13352.799708004582, 13414.195148291134, 13474.19154850673, 13499.257540835348, 9826.459544725109, 11318.4906679198, 11718.765624687288, 12099.697507562381, 12208.694782630506, 11480.425978700865, 11713.121515886172, 11774.587889423829, 12031.518739250332, 12049.879501204876, 11016.17378696585, 12026.398680066137, 12115.75768484643, 12233.266004039786, 12469.937650311691, 8320.459170153921, 8385.622646981023, 8435.746927592181, 8552.871706924278, 8669.6098675561, 8902.332325075775, 11109.777804444027, 11120.110391168526, 11287.887121128684, 11365.431728413712], "value": 9585.759104118695, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.0488919979011, 1564.640132769463, 1580.1072394097334, 1799.0824679413504, 1889.6882014467606, 9058.592363343649, 9510.096540828628, 9524.142827145546, 9761.316707830438, 9805.0, 9542.713718588453, 9748.0, 9750.609975600968, 9754.951225243864, 9761.56072976716, 2128.45724340293, 2366.503034362786, 2481.727010028895, 2496.2261698873317, 2524.684414448194, 2482.913098041569, 2491.028498885436, 2494.3390001649577, 2494.538510375586, 2496.9250922472356, 2419.3709635494724, 2469.740677228883, 2474.9752502474926, 2475.628655701641, 2478.0, 2091.5294058836794, 2171.9782802171935, 2177.640689286266, 2317.9188728394593, 2395.760423957599, 2440.3045132137254, 2474.715407728116, 2482.8262021658493, 2486.1298545509107, 2490.4645501217324, 9558.90441095587, 9608.375455595364, 9619.374740641835, 9634.614615415376, 9643.421394716339, 5426.62013659044, 5549.611527193058, 5565.972170139164, 5573.581981351374, 5580.107182850765, 3513.5608048993877, 3585.103724068983, 3644.5262115925025, 3755.586885442599, 3764.7176461765475, 1141.1498433666889, 1159.611530137405, 1171.9042695080127, 1191.8867707567854, 1200.5257923120405, 13941.512047078304, 13974.441022359093, 13983.79024314636, 13994.230317332542, 14001.71996560063, 4975.303457515951, 5026.597872170218, 5053.418856831438, 5081.898362032739, 5104.4895510449405, 11550.249233799776, 11559.653210403701, 11569.942150289195, 11576.710582235512, 11585.536578536765, 5784.884302314014, 5785.88428231433, 5790.652560846363, 5794.159846822187, 5799.739011744482, 4676.415448068991, 5024.0956627807345, 5147.1507201312115, 5148.047611191867, 5235.319408476874, 4034.9798251008556, 4134.1731653669385, 4164.0, 4175.645070169009, 4183.393407955829, 1308.4308325878083, 1334.166146158651, 1343.7782765843722, 1344.3717532224478, 1347.5822495026573, 986.792773517555, 1001.8196724589498, 1006.7734759679014, 1028.0850043461326, 1034.0693375961694, 6058.1518587397795, 6095.689426773265, 6106.0, 6212.9068063979075, 6437.645929473831, 494.6463278755707, 499.41568365013023, 504.9444561098276, 506.2254750232151, 512.2700152282982, 4225.345071513921, 4289.1421715657, 4304.139172165516, 4329.675274354436, 4384.320430333303, 11977.880221197676, 12333.136680432463, 12393.318367489876, 12398.380080996094, 12455.0, 11206.831897521544, 11719.12106592009, 11740.236884602473, 12137.150399471951, 12257.877421225674, 8702.651893924172, 8880.067592902653, 8966.462012279153, 9069.954650226706, 9127.08729127082, 6252.687365631791, 6349.523785716182, 6363.87272254543, 6410.679466026587, 6570.0, 10492.737681558023, 11288.43557822122, 11326.603568875049, 11342.149338799789, 11456.427178640868, 11026.779464410507, 11208.383538905113, 11220.102391808472, 11261.0, 11329.603463878724, 9238.769030774285, 9333.813323733622, 9426.057394260519, 9490.525473726424, 9497.952510237405, 9248.260139188984, 9300.488473134043, 9319.254459643076, 9350.579223935076, 9383.436993780395, 8047.0745864226365, 8094.797630059295, 8225.095239523527, 8329.416940814328, 8333.041700204554, 8314.08545060055, 8409.83180336402, 8413.3269338454, 8496.957515212385, 8537.402381833212, 7331.303526165006, 7355.8161045974275, 7397.297256760599, 7398.667059982206, 7405.555666659802, 5498.725063746877, 5542.944570554243, 5672.631278966854, 5682.829515114553, 5730.713464326684, 5453.0, 5521.282233309644, 5671.291088613923, 5699.6865172414255, 5734.913976290276], "value": 4908.481764726864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.6037317458097, 348.26168522731814, 348.86219943122467, 352.5575402869402, 357.71382893685046, 5383.865403364918, 5396.811111611094, 5425.9186112208345, 5504.862378440541, 5505.394406615269, 5374.865628359293, 5421.322334708161, 5429.56563474922, 5441.455854414557, 5442.700651464168, 3911.4132880068073, 4097.323941549648, 4292.570742925698, 4296.0, 4298.226319262531, 4241.4274073000215, 4266.210751011073, 4272.273713468718, 4281.229378711831, 4296.591823776736, 4104.322786740199, 4265.658747300224, 4269.082147338321, 4271.9359209611885, 4283.121959998193, 4194.517630472489, 4277.572242775728, 4288.463942007249, 4292.819474644467, 4304.461942257218, 3780.092777733352, 3790.4124860646643, 3816.084139806454, 3826.2972977025233, 3826.4260360945805, 5197.8440646780655, 5209.869753256161, 5271.156614941629, 5279.762410691528, 5281.52466278033, 4896.36347274852, 4912.263160525914, 4932.136876046678, 4951.341300664281, 4955.1328517509655, 5428.45715428458, 5438.184272359138, 5586.301712285965, 5590.944090559124, 5704.600677952545, 4077.734947228421, 4170.582941705805, 4177.26897792885, 4207.200631879933, 4219.156168766228, 5835.533157347444, 5853.414658534155, 5859.589828711949, 5869.559783016291, 5872.324682661506, 4016.5983401660183, 4223.97888010558, 4232.830686772556, 4233.343831706091, 4233.745975241495, 4254.680898932531, 4256.404103425523, 4256.7445953242905, 4266.5946735060115, 4273.230818452646, 4851.175300198975, 4854.927176092361, 4866.05112003156, 4889.755512224375, 4894.19245824435, 5538.335399752055, 5681.659100453903, 5685.545156387479, 5719.28508936383, 5728.971355143198, 1431.5633731711928, 1439.165284135199, 1449.4274761469371, 1452.7675571908444, 1453.4404254362146, 943.3113826906259, 947.6067432015774, 958.4584709639032, 960.5725452173716, 966.2511553545918, 4975.477574854661, 4989.501049894981, 4997.525235102659, 5004.173476681058, 5016.573591244785, 5095.8726031848755, 5187.688738675616, 5195.168772996378, 5204.42751297357, 5245.082110630625, 4613.5386461354265, 4952.068693209651, 4957.926085826738, 5006.974965125224, 5013.1227035268685, 2779.847108409057, 2789.302674331417, 2806.761425278874, 2825.675047369579, 2828.020385729997, 5281.630285880028, 5286.973565132226, 5288.867778305573, 5320.76056577455, 5358.785648574013, 5287.259783630295, 5307.734613269321, 5538.695371754592, 5967.583128832743, 5981.37195594465, 5668.801591944262, 5776.826695199151, 5893.351731309553, 5950.464458198696, 5993.101034844808, 5857.297124345106, 5884.0, 5895.29256489224, 5895.587308888336, 5911.586188966731, 5597.096987024268, 5757.3591526414775, 5776.999999999832, 5814.331351894586, 5828.446297601721, 5874.206982057368, 5958.19564358806, 5960.284765828128, 5961.701914904324, 5983.820485385445, 4279.422277992431, 4289.485261768607, 4295.72077814941, 4303.440552728125, 4322.740635561876, 5646.830595082154, 5839.591228613956, 5843.802020585855, 5927.733252003584, 5949.405059494016, 5717.942820571741, 5754.539636829128, 5790.449907258803, 5794.18881356602, 5797.449242321973, 5669.914951275817, 5725.51333136688, 5748.511376533042, 5773.249477568057, 5780.884382312246, 5608.2148499209325, 5641.238432811682, 5674.77300907959, 5697.772089116389, 5707.800226992035, 5741.684207368635, 5763.250777398911, 5785.334686510937, 5794.362620111869, 5801.216835727123, 5505.9174112387545, 5677.602567820213, 5678.432156784289, 5710.8001219957105, 5713.514351280188], "value": 4290.7327427825785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.2168870285362, 830.6750732581534, 860.3031544448996, 891.6076926152489, 913.401721872174, 14567.490137845178, 15856.445024424147, 16099.436519721812, 16108.75836862445, 16113.838861611395, 15253.69492610147, 16012.43956461524, 16051.357945682188, 16060.598485037879, 16093.034417934903, 862.223998401439, 878.2534845381439, 879.65253724779, 881.4755220643707, 883.2801266967401, 871.6121326009928, 877.1141147441067, 877.6226222724226, 877.8946526416808, 878.2841983783196, 923.5336155241594, 927.3323207290773, 927.3740225347897, 927.4620719982394, 927.6104036304769, 913.1735779119874, 917.3486824354716, 917.3807679816131, 919.0166521821653, 922.0594993107061, 675.9493038022118, 676.2730065179951, 676.64814296566, 676.8071099736601, 676.9898451523231, 15341.769873451907, 15351.846481535265, 15436.691266174726, 15459.845401545954, 15507.302171402314, 14242.928785356007, 14279.286035698278, 14282.0, 14333.78499322511, 14359.497417590333, 12287.447064882102, 12369.929497293677, 12431.316277604728, 12458.439370228361, 12521.499140034388, 3123.063081075691, 3136.325689976666, 3156.8105913645254, 3177.3645270945904, 3282.868685252587, 70108.0, 72660.91008634928, 78023.60988195079, 78358.60820695916, 78402.60798696027, 12302.75394492105, 12394.380280985915, 12567.622971310875, 12664.113512054251, 12827.807582886264, 22302.665460018114, 22459.550808983728, 22474.101035958705, 22512.21207257771, 22547.436314091952, 9200.355975081813, 9386.108319709616, 9412.529373531295, 9556.0, 10003.699889003341, 5013.548780609763, 5108.795648174031, 5224.242484839677, 5352.705601191894, 5377.300950876439, 3768.2086761779783, 3861.362875125629, 3875.651191392732, 3890.6692931100606, 3892.143728379752, 692.5913710910587, 695.9860802783916, 696.8780463418983, 698.0750505580127, 712.3837880233664, 741.2476336518438, 761.4936067515151, 788.7278888783361, 793.928546430824, 819.8729196974479, 10195.184385249162, 10959.50682219302, 11109.277896936674, 11590.420478976017, 11641.708957275967, 744.4193529047352, 817.8732296494053, 824.2252282854098, 842.7724514381083, 852.953087580189, 5106.617003724736, 5343.110017463108, 5378.542823860016, 5410.810621628224, 5461.317335333083, 70914.0, 72103.63948180225, 101123.49438252761, 117763.41118294524, 126623.0, 100255.49872250739, 102001.46997795039, 102944.48527757313, 104981.0, 105301.0, 90071.0, 90860.0, 91531.0, 92620.53689731508, 92919.99999999865, 10023.849642255225, 10164.390136591828, 10211.795764084825, 10306.12397946183, 10392.844107338246, 54138.18792718191, 54932.17601735897, 56050.43949560452, 57166.7141664289, 57549.4245057544, 69052.30947690459, 69237.30762692308, 69476.0, 70156.64921675359, 71468.28531714824, 13675.931620341835, 14058.718825623226, 14069.226192559097, 14371.856281437053, 14457.349419276368, 15572.532824015298, 15749.44876929302, 15910.204489775697, 16008.03951762898, 16364.590885227964, 14816.0, 15182.953034891525, 15453.459128930434, 15845.286962086504, 15959.521214363587, 14828.555143345717, 15479.380824766884, 15638.84361156374, 15895.046297222203, 15926.124063176174, 13971.790423143864, 14434.422623094959, 15050.548483545512, 15198.392064317304, 15414.46049388266, 10869.239153259196, 11034.448277586249, 11484.655460336204, 11574.421278935852, 11679.649610511698, 10527.947360263455, 11255.540614572634, 11264.887351126385, 11287.0, 11398.316101033965], "value": 8005.84748855029, "unit": "score"}], "name": "dromaeo_css", "value": 7583.831956298461, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 111.0, 111.0, 111.0, 110.0, 110.0, 113.0, 110.0, 109.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 125.0, 180.0, 124.0, 134.0, 152.0, 132.0, 160.0, 123.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 160.0, 160.0, 160.0, 159.0, 160.0, 159.0, 161.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 106.0, 75.0, 75.0, 76.0, 74.0, 108.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 113.0, 84.0, 83.0, 85.0, 127.0, 84.0, 85.0, 121.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 145.0, 145.0, 147.0, 148.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 50.0, 52.0, 53.0, 52.0, 52.0, 56.0, 51.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 59.0, 58.0, 58.0, 60.0, 58.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 76.0, 76.0, 77.0, 76.0, 77.0, 105.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 118.0, 119.0, 118.0, 117.0, 118.0, 120.0, 130.0, 119.0], "value": 119.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 156.0, 151.0, 159.0, 157.0, 153.0, 150.0, 155.0, 156.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 60.0, 61.0, 62.0, 59.0, 59.0, 61.0, 59.0], "value": 60.8, "unit": "score"}], "name": "kraken", "value": 1471.8999999999999, "alertThreshold": 2.0}]} 05:15:42 INFO - Return code: 0 05:15:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:15:42 ERROR - # TBPL SUCCESS # 05:15:42 INFO - Running post-action listener: _resource_record_post_action 05:15:42 INFO - ##### 05:15:42 INFO - ##### Finished run-tests step (success) 05:15:42 INFO - ##### 05:15:42 INFO - Running post-run listener: _resource_record_post_run 05:15:43 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 290816; Write bytes: 506654720; Read time: 48; Write time: 347352 05:15:43 INFO - TinderboxPrint: CPU usage
13.1% 05:15:43 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 48 05:15:43 INFO - TinderboxPrint: I/O write bytes / time
506,654,720 / 347,352 05:15:43 INFO - TinderboxPrint: CPU idle
8,240.7 (86.9%) 05:15:43 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 05:15:43 INFO - TinderboxPrint: Swap in / out
0 / 0 05:15:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 227672064; Read time: 0; Write time: 195532 05:15:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253460480; Read time: 32; Write time: 147008 05:15:43 INFO - Running post-run listener: _upload_blobber_files 05:15:43 INFO - Blob upload gear active. 05:15:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:15:43 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 05:15:43 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'] 05:15:43 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 05:15:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:15:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:44 INFO - (blobuploader) - INFO - Done attempting. 05:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:15:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:59 INFO - (blobuploader) - INFO - Done attempting. 05:15:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:15:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:16:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:00 INFO - (blobuploader) - INFO - Done attempting. 05:16:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:00 INFO - Return code: 0 05:16:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/972bd9b5212b4943391f081825d9539e6ed3f0ec05ad2af63ca4325a77b3b057aa2ffefc32eef989c05db49f67c016d11c925ee7f0c8bdacdc5cafb2ba9ddbe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c242e2d885041e3a41fe2f6f6dd84445c1bc92fca2e48eac489e7d5ed2a02f216e8ecd8f3f7b17956f9859c8c9f32123ccd257a79a4a1e11bf2f2372fe4df31e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd3f4cb10ee2bc2bf7d27d227182c2b1c2b7f08488ca224fa554bb58d28db494aa535879122932fd74e3b94035b25788aa52c38c35e55c45a4c8459406bb6ec3"} 05:16:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:00 INFO - Contents: 05:16:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/972bd9b5212b4943391f081825d9539e6ed3f0ec05ad2af63ca4325a77b3b057aa2ffefc32eef989c05db49f67c016d11c925ee7f0c8bdacdc5cafb2ba9ddbe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c242e2d885041e3a41fe2f6f6dd84445c1bc92fca2e48eac489e7d5ed2a02f216e8ecd8f3f7b17956f9859c8c9f32123ccd257a79a4a1e11bf2f2372fe4df31e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd3f4cb10ee2bc2bf7d27d227182c2b1c2b7f08488ca224fa554bb58d28db494aa535879122932fd74e3b94035b25788aa52c38c35e55c45a4c8459406bb6ec3"} 05:16:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:16:00 INFO - Copying logs to upload dir... 05:16:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:16:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.963313 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-22 05:16:00.547178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 05:16:00.550853) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957 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/972bd9b5212b4943391f081825d9539e6ed3f0ec05ad2af63ca4325a77b3b057aa2ffefc32eef989c05db49f67c016d11c925ee7f0c8bdacdc5cafb2ba9ddbe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c242e2d885041e3a41fe2f6f6dd84445c1bc92fca2e48eac489e7d5ed2a02f216e8ecd8f3f7b17956f9859c8c9f32123ccd257a79a4a1e11bf2f2372fe4df31e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd3f4cb10ee2bc2bf7d27d227182c2b1c2b7f08488ca224fa554bb58d28db494aa535879122932fd74e3b94035b25788aa52c38c35e55c45a4c8459406bb6ec3"} build_url:https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/PWpnF-NtTzak_AI3EuYtRg/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/972bd9b5212b4943391f081825d9539e6ed3f0ec05ad2af63ca4325a77b3b057aa2ffefc32eef989c05db49f67c016d11c925ee7f0c8bdacdc5cafb2ba9ddbe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c242e2d885041e3a41fe2f6f6dd84445c1bc92fca2e48eac489e7d5ed2a02f216e8ecd8f3f7b17956f9859c8c9f32123ccd257a79a4a1e11bf2f2372fe4df31e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd3f4cb10ee2bc2bf7d27d227182c2b1c2b7f08488ca224fa554bb58d28db494aa535879122932fd74e3b94035b25788aa52c38c35e55c45a4c8459406bb6ec3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 05:16:00.575947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:16:00.576245) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469187930.482489-1476604957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:16:00.659142) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 05:16:00.659471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 05:16:00.659772) ========= ========= Total master_lag: 0.70 =========