builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1470092730.16 results: success (0) buildid: 20160801133030 builduid: 5f082708c71b4aaebbd410860db72afc revision: 7f5eeb7c5aae745496b85d82c0f26f8fdcf40288 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.160493) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.161405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.161816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.204693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.205030) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 16:05:33-- 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% 70.6M=0s 2016-08-01 16:05:33 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.264530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.483451) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.483846) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.533609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:30.533971) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7f5eeb7c5aae745496b85d82c0f26f8fdcf40288 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7f5eeb7c5aae745496b85d82c0f26f8fdcf40288 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 16:05:33,876 truncating revision to first 12 chars 2016-08-01 16:05:33,876 Setting DEBUG logging. 2016-08-01 16:05:33,876 attempt 1/10 2016-08-01 16:05:33,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7f5eeb7c5aae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 16:05:34,384 unpacking tar archive at: mozilla-inbound-7f5eeb7c5aae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.950451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:31.498500) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:31.498812) ========= script_repo_revision: 7f5eeb7c5aae745496b85d82c0f26f8fdcf40288 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:31.499203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:31.499462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 16:05:31.510150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-01 16:05:31.510410) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:05:34 INFO - MultiFileLogger online at 20160801 16:05:34 in /builds/slave/test 16:05:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:05:34 INFO - {'append_to_log': False, 16:05:34 INFO - 'base_work_dir': '/builds/slave/test', 16:05:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:05:34 INFO - 'branch': 'Mozilla-Inbound', 16:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:05:34 INFO - 'config_files': ('talos/linux_config.py',), 16:05:34 INFO - 'default_actions': ('clobber', 16:05:34 INFO - 'read-buildbot-config', 16:05:34 INFO - 'download-and-extract', 16:05:34 INFO - 'populate-webroot', 16:05:34 INFO - 'create-virtualenv', 16:05:34 INFO - 'install', 16:05:34 INFO - 'run-tests'), 16:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:05:34 INFO - 'download_minidump_stackwalk': True, 16:05:34 INFO - 'download_symbols': 'ondemand', 16:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:05:34 INFO - 'installer_path': 'installer.exe', 16:05:34 INFO - 'log_level': 'info', 16:05:34 INFO - 'log_name': 'talos', 16:05:34 INFO - 'log_to_console': True, 16:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:05:34 INFO - 'opt_config_files': (), 16:05:34 INFO - 'pip_index': False, 16:05:34 INFO - 'sps_profile': False, 16:05:34 INFO - 'sps_profile_interval': 0, 16:05:34 INFO - 'suite': 'dromaeojs', 16:05:34 INFO - 'system_bits': '32', 16:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:05:34 INFO - 'title': 'talos-linux64-ix-069', 16:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:05:34 INFO - 'use_talos_json': True, 16:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:05:34 INFO - 'work_dir': 'build'} 16:05:34 INFO - [mozharness: 2016-08-01 23:05:34.939615Z] Running clobber step. 16:05:34 INFO - Running pre-action listener: _resource_record_pre_action 16:05:34 INFO - Running main action method: clobber 16:05:34 INFO - rmtree: /builds/slave/test/build 16:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:05:35 INFO - Running post-action listener: _resource_record_post_action 16:05:35 INFO - [mozharness: 2016-08-01 23:05:35.417747Z] Finished clobber step (success) 16:05:35 INFO - [mozharness: 2016-08-01 23:05:35.417877Z] Running read-buildbot-config step. 16:05:35 INFO - Running pre-action listener: _resource_record_pre_action 16:05:35 INFO - Running main action method: read_buildbot_config 16:05:35 INFO - Using buildbot properties: 16:05:35 INFO - { 16:05:35 INFO - "project": "", 16:05:35 INFO - "product": "firefox", 16:05:35 INFO - "script_repo_revision": "production", 16:05:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:05:35 INFO - "repository": "", 16:05:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:05:35 INFO - "buildid": "20160801133030", 16:05:35 INFO - "pgo_build": "True", 16:05:35 INFO - "basedir": "/builds/slave/test", 16:05:35 INFO - "buildnumber": 1436, 16:05:35 INFO - "slavename": "talos-linux64-ix-069", 16:05:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:05:35 INFO - "platform": "ubuntu64_hw", 16:05:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:05:35 INFO - "branch": "mozilla-inbound", 16:05:35 INFO - "repo_path": "integration/mozilla-inbound", 16:05:35 INFO - "revision": "7f5eeb7c5aae745496b85d82c0f26f8fdcf40288", 16:05:35 INFO - "stage_platform": "linux64-pgo", 16:05:35 INFO - "builduid": "5f082708c71b4aaebbd410860db72afc", 16:05:35 INFO - "slavebuilddir": "test" 16:05:35 INFO - } 16:05:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:05:35 INFO - Running post-action listener: _resource_record_post_action 16:05:35 INFO - [mozharness: 2016-08-01 23:05:35.420321Z] Finished read-buildbot-config step (success) 16:05:35 INFO - [mozharness: 2016-08-01 23:05:35.420410Z] Running download-and-extract step. 16:05:35 INFO - Running pre-action listener: _resource_record_pre_action 16:05:35 INFO - Running main action method: download_and_extract 16:05:35 INFO - mkdir: /builds/slave/test/build/tests 16:05: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')]} 16:05:35 INFO - https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:05:36 INFO - Downloaded 1361 bytes. 16:05:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:05:36 INFO - Using the following test package requirements: 16:05:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:05:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:05:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:05:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'jsshell-linux-x86_64.zip'], 16:05:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:05:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:05:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:05:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:05:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:05:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:05:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:05:36 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')]} 16:05:36 INFO - https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:05:38 INFO - Downloaded 21809801 bytes. 16:05:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:05:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:05:39 INFO - Return code: 0 16:05:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:05:39 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')]} 16:05:39 INFO - https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:05:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:05:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:05:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:05:40 INFO - Downloaded 21809801 bytes. 16:05:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:05:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:05:42 INFO - Return code: 0 16:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:42 INFO - https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:05:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:05:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:05:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:05:43 INFO - Downloaded 14413723 bytes. 16:05:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:05:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:05:43 INFO - Return code: 0 16:05: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')]} 16:05:43 INFO - https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:05:44 INFO - Downloaded 59399677 bytes. 16:05:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:05:44 INFO - mkdir: /builds/slave/test/properties 16:05:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:44 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:44 INFO - Contents: 16:05:44 INFO - build_url:https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:05:45 INFO - Running post-action listener: _resource_record_post_action 16:05:45 INFO - Running post-action listener: set_extra_try_arguments 16:05:45 INFO - [mozharness: 2016-08-01 23:05:45.263349Z] Finished download-and-extract step (success) 16:05:45 INFO - [mozharness: 2016-08-01 23:05:45.263583Z] Running populate-webroot step. 16:05:45 INFO - Running pre-action listener: _resource_record_pre_action 16:05:45 INFO - Running main action method: populate_webroot 16:05:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:05:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:05:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:05:45 INFO - '--tppagecycles', 16:05:45 INFO - '7'], 16:05:45 INFO - 'tests': ['tsvgm']}}, 16:05:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:05:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:05:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['damp', 'tps']}, 16:05:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'tests': ['damp', 'tps']}, 16:05:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['dromaeo_dom']}, 16:05:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['basic_compositor_video']}, 16:05:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:05:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['a11yr', 16:05:45 INFO - 'ts_paint', 16:05:45 INFO - 'tpaint', 16:05:45 INFO - 'sessionrestore', 16:05:45 INFO - 'sessionrestore_no_auto_restore', 16:05:45 INFO - 'tabpaint']}, 16:05:45 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:45 INFO - 'ts_paint', 16:05:45 INFO - 'tpaint', 16:05:45 INFO - 'sessionrestore', 16:05:45 INFO - 'sessionrestore_no_auto_restore', 16:05:45 INFO - 'tabpaint']}, 16:05:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:05:45 INFO - 'ts_paint', 16:05:45 INFO - 'tpaint', 16:05:45 INFO - 'sessionrestore', 16:05:45 INFO - 'sessionrestore_no_auto_restore', 16:05:45 INFO - 'tabpaint']}, 16:05:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:05:45 INFO - 'ts_paint', 16:05:45 INFO - 'tpaint', 16:05:45 INFO - 'sessionrestore', 16:05:45 INFO - 'sessionrestore_no_auto_restore', 16:05:45 INFO - 'tabpaint']}, 16:05:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['a11yr', 16:05:45 INFO - 'ts_paint', 16:05:45 INFO - 'tpaint', 16:05:45 INFO - 'sessionrestore', 16:05:45 INFO - 'sessionrestore_no_auto_restore', 16:05:45 INFO - 'tabpaint']}, 16:05:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['a11yr', 16:05:45 INFO - 'ts_paint', 16:05:45 INFO - 'tpaint', 16:05:45 INFO - 'sessionrestore', 16:05:45 INFO - 'sessionrestore_no_auto_restore', 16:05:45 INFO - 'tabpaint']}, 16:05:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['tsvgx', 16:05:45 INFO - 'tsvgr_opacity', 16:05:45 INFO - 'tart', 16:05:45 INFO - 'tscrollx', 16:05:45 INFO - 'cart']}, 16:05:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:45 INFO - 'tsvgr_opacity', 16:05:45 INFO - 'tart', 16:05:45 INFO - 'tscrollx', 16:05:45 INFO - 'cart']}, 16:05:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'talos_options': ['--disable-e10s'], 16:05:45 INFO - 'tests': ['tp5o']}, 16:05:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'tests': ['tp5o']}, 16:05:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'talos_options': ['--disable-e10s', 16:05:45 INFO - '--xperf_path', 16:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:45 INFO - 'tests': ['tp5n']}, 16:05:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:45 INFO - 'talos_options': ['--xperf_path', 16:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:45 INFO - 'tests': ['tp5n']}}, 16:05:45 INFO - 'talos.zip': {'path': '', 16:05:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:05:45 INFO - Running post-action listener: _resource_record_post_action 16:05:45 INFO - [mozharness: 2016-08-01 23:05:45.280515Z] Finished populate-webroot step (success) 16:05:45 INFO - [mozharness: 2016-08-01 23:05:45.280603Z] Running create-virtualenv step. 16:05:45 INFO - Running pre-action listener: _resource_record_pre_action 16:05:45 INFO - Running main action method: create_virtualenv 16:05:45 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:45 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 16:05:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:05:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:45 INFO - Using real prefix '/usr' 16:05:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:47 INFO - Installing pip.................done. 16:05:47 INFO - Return code: 0 16:05:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:47 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:05:47 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 16:05:47 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 16:05:47 INFO - Using env: {'DISPLAY': ':0', 16:05:47 INFO - 'HOME': '/home/cltbld', 16:05:47 INFO - 'LANG': 'en_US.UTF-8', 16:05:47 INFO - 'LANGUAGE': 'en_US:en', 16:05:47 INFO - 'LOGNAME': 'cltbld', 16:05:47 INFO - 'MAIL': '/var/mail/cltbld', 16:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:47 INFO - 'MOZ_NO_REMOTE': '1', 16:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:47 INFO - 'NO_EM_RESTART': '1', 16:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:47 INFO - 'PWD': '/builds/slave/test', 16:05:47 INFO - 'SHELL': '/bin/bash', 16:05:47 INFO - 'SHLVL': '1', 16:05:47 INFO - 'TERM': 'linux', 16:05:47 INFO - 'TMOUT': '86400', 16:05:47 INFO - 'USER': 'cltbld', 16:05:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:47 INFO - '_': '/tools/buildbot/bin/python'} 16:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:48 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 16:05:48 INFO - Cleaning up... 16:05:48 INFO - Return code: 0 16:05:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:05:48 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')]} 16:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:48 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')]} 16:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:48 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:05:48 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 16:05:48 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 16:05:48 INFO - Using env: {'DISPLAY': ':0', 16:05:48 INFO - 'HOME': '/home/cltbld', 16:05:48 INFO - 'LANG': 'en_US.UTF-8', 16:05:48 INFO - 'LANGUAGE': 'en_US:en', 16:05:48 INFO - 'LOGNAME': 'cltbld', 16:05:48 INFO - 'MAIL': '/var/mail/cltbld', 16:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:48 INFO - 'MOZ_NO_REMOTE': '1', 16:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:48 INFO - 'NO_EM_RESTART': '1', 16:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:48 INFO - 'PWD': '/builds/slave/test', 16:05:48 INFO - 'SHELL': '/bin/bash', 16:05:48 INFO - 'SHLVL': '1', 16:05:48 INFO - 'TERM': 'linux', 16:05:48 INFO - 'TMOUT': '86400', 16:05:48 INFO - 'USER': 'cltbld', 16:05:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:48 INFO - '_': '/tools/buildbot/bin/python'} 16:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:48 INFO - Downloading/unpacking psutil>=3.1.1 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:05:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:50 INFO - Installing collected packages: psutil 16:05:50 INFO - Running setup.py install for psutil 16:05:50 INFO - building 'psutil._psutil_linux' extension 16:05:50 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 16:05:50 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 16:05:50 INFO - building 'psutil._psutil_posix' extension 16:05:50 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 16:05:50 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 16:05:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:50 INFO - Successfully installed psutil 16:05:50 INFO - Cleaning up... 16:05:50 INFO - Return code: 0 16:05:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:50 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:05:50 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 16:05:50 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 16:05:50 INFO - Using env: {'DISPLAY': ':0', 16:05:50 INFO - 'HOME': '/home/cltbld', 16:05:50 INFO - 'LANG': 'en_US.UTF-8', 16:05:50 INFO - 'LANGUAGE': 'en_US:en', 16:05:50 INFO - 'LOGNAME': 'cltbld', 16:05:50 INFO - 'MAIL': '/var/mail/cltbld', 16:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:50 INFO - 'MOZ_NO_REMOTE': '1', 16:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:50 INFO - 'NO_EM_RESTART': '1', 16:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:50 INFO - 'PWD': '/builds/slave/test', 16:05:50 INFO - 'SHELL': '/bin/bash', 16:05:50 INFO - 'SHLVL': '1', 16:05:50 INFO - 'TERM': 'linux', 16:05:50 INFO - 'TMOUT': '86400', 16:05:50 INFO - 'USER': 'cltbld', 16:05:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:50 INFO - '_': '/tools/buildbot/bin/python'} 16:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:05:53 INFO - Installing collected packages: mozsystemmonitor 16:05:53 INFO - Running setup.py install for mozsystemmonitor 16:05:53 INFO - Successfully installed mozsystemmonitor 16:05:53 INFO - Cleaning up... 16:05:53 INFO - Return code: 0 16:05:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:05:53 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')]} 16:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:53 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')]} 16:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:53 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:05:53 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 16:05:53 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 16:05:53 INFO - Using env: {'DISPLAY': ':0', 16:05:53 INFO - 'HOME': '/home/cltbld', 16:05:53 INFO - 'LANG': 'en_US.UTF-8', 16:05:53 INFO - 'LANGUAGE': 'en_US:en', 16:05:53 INFO - 'LOGNAME': 'cltbld', 16:05:53 INFO - 'MAIL': '/var/mail/cltbld', 16:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:53 INFO - 'MOZ_NO_REMOTE': '1', 16:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:53 INFO - 'NO_EM_RESTART': '1', 16:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:53 INFO - 'PWD': '/builds/slave/test', 16:05:53 INFO - 'SHELL': '/bin/bash', 16:05:53 INFO - 'SHLVL': '1', 16:05:53 INFO - 'TERM': 'linux', 16:05:53 INFO - 'TMOUT': '86400', 16:05:53 INFO - 'USER': 'cltbld', 16:05:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:53 INFO - '_': '/tools/buildbot/bin/python'} 16:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:53 INFO - Downloading/unpacking jsonschema==2.5.1 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:05:55 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 16:05:55 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 16:05:55 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 16:05:55 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 16:05:55 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 16:05:55 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 16:05:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:05:55 INFO - warning: no files found matching '*.txt' 16:05:55 INFO - no previously-included directories found matching 'build' 16:05:55 INFO - no previously-included directories found matching 'dist' 16:05:55 INFO - no previously-included directories found matching '.git*' 16:05:55 INFO - Installing collected packages: jsonschema, functools32 16:05:55 INFO - Running setup.py install for functools32 16:05:55 INFO - warning: no files found matching '*.txt' 16:05:55 INFO - no previously-included directories found matching 'build' 16:05:55 INFO - no previously-included directories found matching 'dist' 16:05:55 INFO - no previously-included directories found matching '.git*' 16:05:55 INFO - Successfully installed jsonschema functools32 16:05:55 INFO - Cleaning up... 16:05:55 INFO - Return code: 0 16:05:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:55 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:05:55 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:05:55 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 functools32==3.2.3-2 16:05:55 INFO - Using env: {'DISPLAY': ':0', 16:05:55 INFO - 'HOME': '/home/cltbld', 16:05:55 INFO - 'LANG': 'en_US.UTF-8', 16:05:55 INFO - 'LANGUAGE': 'en_US:en', 16:05:55 INFO - 'LOGNAME': 'cltbld', 16:05:55 INFO - 'MAIL': '/var/mail/cltbld', 16:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:55 INFO - 'MOZ_NO_REMOTE': '1', 16:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:55 INFO - 'NO_EM_RESTART': '1', 16:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:55 INFO - 'PWD': '/builds/slave/test', 16:05:55 INFO - 'SHELL': '/bin/bash', 16:05:55 INFO - 'SHLVL': '1', 16:05:55 INFO - 'TERM': 'linux', 16:05:55 INFO - 'TMOUT': '86400', 16:05:55 INFO - 'USER': 'cltbld', 16:05:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:55 INFO - '_': '/tools/buildbot/bin/python'} 16:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:05:55 INFO - Cleaning up... 16:05:56 INFO - Return code: 0 16:05:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:05:56 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')]} 16:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:56 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')]} 16:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:56 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:05:56 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 16:05:56 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 16:05:56 INFO - Using env: {'DISPLAY': ':0', 16:05:56 INFO - 'HOME': '/home/cltbld', 16:05:56 INFO - 'LANG': 'en_US.UTF-8', 16:05:56 INFO - 'LANGUAGE': 'en_US:en', 16:05:56 INFO - 'LOGNAME': 'cltbld', 16:05:56 INFO - 'MAIL': '/var/mail/cltbld', 16:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:56 INFO - 'MOZ_NO_REMOTE': '1', 16:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:56 INFO - 'NO_EM_RESTART': '1', 16:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:56 INFO - 'PWD': '/builds/slave/test', 16:05:56 INFO - 'SHELL': '/bin/bash', 16:05:56 INFO - 'SHLVL': '1', 16:05:56 INFO - 'TERM': 'linux', 16:05:56 INFO - 'TMOUT': '86400', 16:05:56 INFO - 'USER': 'cltbld', 16:05:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:56 INFO - '_': '/tools/buildbot/bin/python'} 16:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:05:56 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 16:05:56 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 16:05:56 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 16:05:56 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 16:05:56 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 16:05:56 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 16:05:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 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 16:05:58 INFO - Downloading docopt-0.6.1.tar.gz 16:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:58 INFO - Running setup.py install for blobuploader 16:05:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:58 INFO - Running setup.py install for requests 16:05:59 INFO - Running setup.py install for docopt 16:05:59 INFO - Successfully installed blobuploader requests docopt 16:05:59 INFO - Cleaning up... 16:05:59 INFO - Return code: 0 16:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:59 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:05:59 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 16:05:59 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 16:05:59 INFO - Using env: {'DISPLAY': ':0', 16:05:59 INFO - 'HOME': '/home/cltbld', 16:05:59 INFO - 'LANG': 'en_US.UTF-8', 16:05:59 INFO - 'LANGUAGE': 'en_US:en', 16:05:59 INFO - 'LOGNAME': 'cltbld', 16:05:59 INFO - 'MAIL': '/var/mail/cltbld', 16:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:59 INFO - 'MOZ_NO_REMOTE': '1', 16:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:59 INFO - 'NO_EM_RESTART': '1', 16:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:59 INFO - 'PWD': '/builds/slave/test', 16:05:59 INFO - 'SHELL': '/bin/bash', 16:05:59 INFO - 'SHLVL': '1', 16:05:59 INFO - 'TERM': 'linux', 16:05:59 INFO - 'TMOUT': '86400', 16:05:59 INFO - 'USER': 'cltbld', 16:05:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:59 INFO - '_': '/tools/buildbot/bin/python'} 16:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:59 INFO - Running setup.py (path:/tmp/pip-eH5F8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:59 INFO - Running setup.py (path:/tmp/pip-cGc9r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:59 INFO - Running setup.py (path:/tmp/pip-z8VP5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:59 INFO - Running setup.py (path:/tmp/pip-oGEapi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:59 INFO - Running setup.py (path:/tmp/pip-MRy9JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:00 INFO - Running setup.py (path:/tmp/pip-mLytwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:00 INFO - Running setup.py (path:/tmp/pip-WbOWiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:00 INFO - Running setup.py (path:/tmp/pip-VFZMy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:00 INFO - Running setup.py (path:/tmp/pip-W0tV_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:00 INFO - Running setup.py (path:/tmp/pip-TbT8gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:00 INFO - Running setup.py (path:/tmp/pip-OPso7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:00 INFO - Running setup.py (path:/tmp/pip-sNX8x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:00 INFO - Running setup.py (path:/tmp/pip-7WxoBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:00 INFO - Running setup.py (path:/tmp/pip-B3J_va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:00 INFO - Running setup.py (path:/tmp/pip-K3JjJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:00 INFO - Running setup.py (path:/tmp/pip-qYT_0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:00 INFO - Running setup.py (path:/tmp/pip-dN8wMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:06:00 INFO - Running setup.py install for manifestparser 16:06:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Running setup.py install for mozcrash 16:06:01 INFO - Running setup.py install for mozdebug 16:06:01 INFO - Running setup.py install for mozdevice 16:06:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Running setup.py install for mozfile 16:06:01 INFO - Running setup.py install for mozhttpd 16:06:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Running setup.py install for mozinfo 16:06:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Running setup.py install for mozInstall 16:06:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Running setup.py install for mozleak 16:06:01 INFO - Running setup.py install for mozlog 16:06:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:06:01 INFO - Running setup.py install for moznetwork 16:06:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:06:02 INFO - Running setup.py install for mozprocess 16:06:02 INFO - Running setup.py install for mozprofile 16:06:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:06:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:06:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:06:02 INFO - Running setup.py install for mozrunner 16:06:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:06:02 INFO - Running setup.py install for mozscreenshot 16:06:02 INFO - Running setup.py install for moztest 16:06:02 INFO - Running setup.py install for mozversion 16:06:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:06:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:06:02 INFO - Cleaning up... 16:06:02 INFO - Return code: 0 16:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:02 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:06:02 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 16:06:02 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 16:06:02 INFO - Using env: {'DISPLAY': ':0', 16:06:02 INFO - 'HOME': '/home/cltbld', 16:06:02 INFO - 'LANG': 'en_US.UTF-8', 16:06:02 INFO - 'LANGUAGE': 'en_US:en', 16:06:02 INFO - 'LOGNAME': 'cltbld', 16:06:02 INFO - 'MAIL': '/var/mail/cltbld', 16:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:02 INFO - 'MOZ_NO_REMOTE': '1', 16:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:02 INFO - 'NO_EM_RESTART': '1', 16:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:02 INFO - 'PWD': '/builds/slave/test', 16:06:02 INFO - 'SHELL': '/bin/bash', 16:06:02 INFO - 'SHLVL': '1', 16:06:02 INFO - 'TERM': 'linux', 16:06:02 INFO - 'TMOUT': '86400', 16:06:02 INFO - 'USER': 'cltbld', 16:06:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:02 INFO - '_': '/tools/buildbot/bin/python'} 16:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:02 INFO - Running setup.py (path:/tmp/pip-lWY3Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:03 INFO - Running setup.py (path:/tmp/pip-igKRgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:03 INFO - Running setup.py (path:/tmp/pip-qzrkhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:03 INFO - Running setup.py (path:/tmp/pip-zSZRf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:03 INFO - Running setup.py (path:/tmp/pip-QXPwJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:03 INFO - Running setup.py (path:/tmp/pip-1tPcqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:03 INFO - Running setup.py (path:/tmp/pip-9JbNaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:03 INFO - Running setup.py (path:/tmp/pip-PyrMMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:03 INFO - Running setup.py (path:/tmp/pip-eZ478G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:03 INFO - Running setup.py (path:/tmp/pip-zCsb0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:03 INFO - Running setup.py (path:/tmp/pip-BGT75n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:03 INFO - Running setup.py (path:/tmp/pip-TZ3Keu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:03 INFO - Running setup.py (path:/tmp/pip-YUiLuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:03 INFO - Running setup.py (path:/tmp/pip-qCAoUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:03 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)) 16:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:03 INFO - Running setup.py (path:/tmp/pip-1hAY74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:04 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)) 16:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:04 INFO - Running setup.py (path:/tmp/pip-lADDE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:04 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)) 16:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:04 INFO - Running setup.py (path:/tmp/pip-TgITDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:04 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)) 16:06:04 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)) 16:06:04 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)) 16:06:04 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)) 16:06:04 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)) 16:06:04 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)) 16:06:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:06:04 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 16:06:04 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 16:06:04 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 16:06:04 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 16:06:04 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 16:06:04 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 16:06:06 INFO - Downloading blessings-1.6.tar.gz 16:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:06:06 INFO - Installing collected packages: blessings 16:06:06 INFO - Running setup.py install for blessings 16:06:06 INFO - Successfully installed blessings 16:06:06 INFO - Cleaning up... 16:06:06 INFO - Return code: 0 16:06:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:06 INFO - Reading from file tmpfile_stdout 16:06:06 INFO - Current package versions: 16:06:06 INFO - argparse == 1.2.1 16:06:06 INFO - blessings == 1.6 16:06:06 INFO - blobuploader == 1.2.4 16:06:06 INFO - docopt == 0.6.1 16:06:06 INFO - functools32 == 3.2.3-2 16:06:06 INFO - jsonschema == 2.5.1 16:06:06 INFO - manifestparser == 1.1 16:06:06 INFO - mozInstall == 1.12 16:06:06 INFO - mozcrash == 0.17 16:06:06 INFO - mozdebug == 0.1 16:06:06 INFO - mozdevice == 0.48 16:06:06 INFO - mozfile == 1.2 16:06:06 INFO - mozhttpd == 0.7 16:06:06 INFO - mozinfo == 0.9 16:06:06 INFO - mozleak == 0.1 16:06:06 INFO - mozlog == 3.3 16:06:06 INFO - moznetwork == 0.27 16:06:06 INFO - mozprocess == 0.23 16:06:06 INFO - mozprofile == 0.28 16:06:06 INFO - mozrunner == 6.12 16:06:06 INFO - mozscreenshot == 0.1 16:06:06 INFO - mozsystemmonitor == 0.3 16:06:06 INFO - moztest == 0.7 16:06:06 INFO - mozversion == 1.4 16:06:06 INFO - psutil == 3.1.1 16:06:06 INFO - requests == 1.2.3 16:06:06 INFO - wsgiref == 0.1.2 16:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:06 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')]} 16:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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')]} 16:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:06:06 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 16:06:06 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 16:06:06 INFO - Using env: {'DISPLAY': ':0', 16:06:06 INFO - 'HOME': '/home/cltbld', 16:06:06 INFO - 'LANG': 'en_US.UTF-8', 16:06:06 INFO - 'LANGUAGE': 'en_US:en', 16:06:06 INFO - 'LOGNAME': 'cltbld', 16:06:06 INFO - 'MAIL': '/var/mail/cltbld', 16:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:06 INFO - 'MOZ_NO_REMOTE': '1', 16:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:06 INFO - 'NO_EM_RESTART': '1', 16:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:06 INFO - 'PWD': '/builds/slave/test', 16:06:06 INFO - 'SHELL': '/bin/bash', 16:06:06 INFO - 'SHLVL': '1', 16:06:06 INFO - 'TERM': 'linux', 16:06:06 INFO - 'TMOUT': '86400', 16:06:06 INFO - 'USER': 'cltbld', 16:06:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:06 INFO - '_': '/tools/buildbot/bin/python'} 16:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 INFO - Cleaning up... 16:06:06 INFO - Return code: 0 16:06:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:06:06 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')]} 16:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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')]} 16:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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 0x14aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', '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 16:06:06 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 16:06:06 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 16:06:06 INFO - Using env: {'DISPLAY': ':0', 16:06:06 INFO - 'HOME': '/home/cltbld', 16:06:06 INFO - 'LANG': 'en_US.UTF-8', 16:06:06 INFO - 'LANGUAGE': 'en_US:en', 16:06:06 INFO - 'LOGNAME': 'cltbld', 16:06:06 INFO - 'MAIL': '/var/mail/cltbld', 16:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:06 INFO - 'MOZ_NO_REMOTE': '1', 16:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:06 INFO - 'NO_EM_RESTART': '1', 16:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:06 INFO - 'PWD': '/builds/slave/test', 16:06:06 INFO - 'SHELL': '/bin/bash', 16:06:06 INFO - 'SHLVL': '1', 16:06:06 INFO - 'TERM': 'linux', 16:06:06 INFO - 'TMOUT': '86400', 16:06:06 INFO - 'USER': 'cltbld', 16:06:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:06 INFO - '_': '/tools/buildbot/bin/python'} 16:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:06:06 INFO - Cleaning up... 16:06:06 INFO - Return code: 0 16:06:06 INFO - Running post-action listener: _resource_record_post_action 16:06:06 INFO - Running post-action listener: _start_resource_monitoring 16:06:07 INFO - Starting resource monitoring. 16:06:07 INFO - [mozharness: 2016-08-01 23:06:07.004916Z] Finished create-virtualenv step (success) 16:06:07 INFO - [mozharness: 2016-08-01 23:06:07.005553Z] Running install step. 16:06:07 INFO - Running pre-action listener: _resource_record_pre_action 16:06:07 INFO - Running main action method: install 16:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:07 INFO - Reading from file tmpfile_stdout 16:06:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:06:07 INFO - Reading from file tmpfile_stdout 16:06:07 INFO - Output received: 16:06:07 INFO - Usage: mozinstall [options] installer 16:06:07 INFO - Options: 16:06:07 INFO - -h, --help show this help message and exit 16:06:07 INFO - -d DEST, --destination=DEST 16:06:07 INFO - Directory to install application into. [default: 16:06:07 INFO - "/builds/slave/test"] 16:06:07 INFO - --app=APP Application being installed. [default: firefox] 16:06:07 INFO - mkdir: /builds/slave/test/build/application 16:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:06:24 INFO - Reading from file tmpfile_stdout 16:06:24 INFO - Output received: 16:06:24 INFO - /builds/slave/test/build/application/firefox/firefox 16:06:24 INFO - Running post-action listener: _resource_record_post_action 16:06:24 INFO - [mozharness: 2016-08-01 23:06:24.226387Z] Finished install step (success) 16:06:24 INFO - [mozharness: 2016-08-01 23:06:24.226664Z] Running run-tests step. 16:06:24 INFO - Running pre-action listener: _resource_record_pre_action 16:06:24 INFO - Running main action method: run_tests 16:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:06:24 INFO - Python 2.7.3 16:06:24 INFO - Return code: 0 16:06:24 INFO - grabbing minidump binary from tooltool 16:06:24 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')]} 16:06:24 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 0x17693b0>, '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 0x176a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:06:24 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 16:06:24 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 16:06:24 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 16:06:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:06:24 INFO - Return code: 0 16:06:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:06:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 16:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 16:06:24 INFO - Using env: {'DISPLAY': ':0', 16:06:24 INFO - 'HOME': '/home/cltbld', 16:06:24 INFO - 'LANG': 'en_US.UTF-8', 16:06:24 INFO - 'LANGUAGE': 'en_US:en', 16:06:24 INFO - 'LOGNAME': 'cltbld', 16:06:24 INFO - 'MAIL': '/var/mail/cltbld', 16:06:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:24 INFO - 'MOZ_NO_REMOTE': '1', 16:06:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:24 INFO - 'NO_EM_RESTART': '1', 16:06:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:24 INFO - 'PWD': '/builds/slave/test', 16:06:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:24 INFO - 'SHELL': '/bin/bash', 16:06:24 INFO - 'SHLVL': '1', 16:06:24 INFO - 'TERM': 'linux', 16:06:24 INFO - 'TMOUT': '86400', 16:06:24 INFO - 'USER': 'cltbld', 16:06:24 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761', 16:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:24 INFO - '_': '/tools/buildbot/bin/python'} 16:06:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 16:06:24 INFO - mozversion application_buildid: 20160801133030 16:06:24 INFO - mozversion application_changeset: 7f5eeb7c5aae745496b85d82c0f26f8fdcf40288 16:06:24 INFO - mozversion application_display_name: Nightly 16:06:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:06:24 INFO - mozversion application_name: Firefox 16:06:24 INFO - mozversion application_remotingname: firefox 16:06:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:06:24 INFO - mozversion application_vendor: Mozilla 16:06:24 INFO - mozversion application_version: 50.0a1 16:06:24 INFO - mozversion platform_buildid: 20160801133030 16:06:24 INFO - mozversion platform_changeset: 7f5eeb7c5aae745496b85d82c0f26f8fdcf40288 16:06:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:06:24 INFO - mozversion platform_version: 50.0a1 16:06:24 INFO - using testdate: 1470092784 16:06:24 INFO - actual date: 1470092784 16:06:24 INFO - starting webserver on 'localhost:40544' 16:06:24 INFO - SUITE-START | Running 2 tests 16:06:24 INFO - TEST-START | dromaeo_css 16:06:24 INFO - operating with platform_type : linux_ 16:06:24 INFO - Initialising browser for dromaeo_css test... 16:06:24 INFO - TEST-INFO | started process 23891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi7F3z3/profile http://localhost:40544/getInfo.html) 16:06:28 INFO - PROCESS | 23891 | __metrics Screen width/height:1600/1200 16:06:28 INFO - PROCESS | 23891 | colorDepth:24 16:06:28 INFO - PROCESS | 23891 | Browser inner width/height: 1024/697 16:06:28 INFO - PROCESS | 23891 | __metrics 16:06:29 INFO - PROCESS | 23891 | 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" 16:06:29 INFO - PROCESS | 23891 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:30 INFO - TEST-INFO | 23891: exit 0 16:06:30 INFO - Browser initialized. 16:06:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:30 INFO - TEST-INFO | started process 23970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi7F3z3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:42 INFO - PROCESS | 23970 | RSS: Main: 155967488 16:06:42 INFO - PROCESS | 23970 | 16:07:33 INFO - PROCESS | 23970 | 1470092853433 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] 16:09:42 INFO - PROCESS | 23970 | Cycle 1(1): loaded http://localhost:40544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40544/tests/dromaeo/cssquery-ext.html) 16:09:43 INFO - PROCESS | 23970 | RSS: Main: 260050944 16:09:43 INFO - PROCESS | 23970 | 16:12:45 INFO - PROCESS | 23970 | Cycle 1(1): loaded http://localhost:40544/tests/dromaeo/cssquery-ext.html (next: http://localhost:40544/tests/dromaeo/cssquery-jquery.html) 16:12:46 INFO - PROCESS | 23970 | RSS: Main: 243044352 16:12:46 INFO - PROCESS | 23970 | 16:15:48 INFO - PROCESS | 23970 | Cycle 1(1): loaded http://localhost:40544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40544/tests/dromaeo/cssquery-mootools.html) 16:15:49 INFO - PROCESS | 23970 | RSS: Main: 183836672 16:15:49 INFO - PROCESS | 23970 | 16:18:51 INFO - PROCESS | 23970 | Cycle 1(1): loaded http://localhost:40544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40544/tests/dromaeo/cssquery-prototype.html) 16:18:51 INFO - PROCESS | 23970 | RSS: Main: 184188928 16:18:51 INFO - PROCESS | 23970 | 16:21:54 INFO - PROCESS | 23970 | Cycle 1(1): loaded http://localhost:40544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40544/tests/dromaeo/cssquery-yui.html) 16:21:54 INFO - PROCESS | 23970 | RSS: Main: 185892864 16:21:54 INFO - PROCESS | 23970 | 16:24:57 INFO - PROCESS | 23970 | Cycle 1(1): loaded http://localhost:40544/tests/dromaeo/cssquery-yui.html (next: http://localhost:40544/tests/dromaeo/cssquery-dojo.html) 16:24:58 INFO - PROCESS | 23970 | RSS: Main: 274841600 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | __start_tp_report 16:24:58 INFO - PROCESS | 23970 | _x_x_mozilla_page_load 16:24:58 INFO - PROCESS | 23970 | _x_x_mozilla_page_load_details 16:24:58 INFO - PROCESS | 23970 | |i|pagename|runs| 16:24:58 INFO - PROCESS | 23970 | |0;dojo.html;2974.5835583018365;2976.0625402998057;2995.341024974506;3007.2632205109753;3031.3179534604715;5094.923576146356;5143.871403214922;5161.096808058589;5170.9482905170935;5222.34720659917;5186.611004174683;5200.583953283738;5243.580513558915;5246.921296180561;5254.7635356408955;4741.7154970701695;4760.404949381327;4768.308595253686;4772.236442169254;4866;4780.713157210561;4813.205821039524;4814.9759251203695;4823.951760482403;4835.323054772335;4536.795844187003;4588.7476188809605;4745.786439610191;4808.567228949411;4815.301781241717;4719.268513380397;4724.149653062447;4730.787114579852;4797.928031079537;4847.878803029917;4773.37946067009;4778.474367819572;4785.856424307276;4796.544328288807;4807.278908163768;5057.367829021372;5112.46319136489;5245.86885327866;5264.894702105975;5289.418164001957;5507.834764957058;5545.944540554583;5546.362168350651;5549.861253468655;5551.2228288039705;5569.888602227933;5594.440555944414;5610.635308704962;5610.971945140289;5615;5008.373953255843;5095.414027386824;5147.922781158286;5179.404368497596;5211.270422140903;5707.3721890592005;5741.138829175574;5742.167385729046;5742.7702891883855;5748.31020277561;5517.144842549411;5526.668399896019;5527.50252477279;5528.612997090165;5530.723463826793;5353.848922481685;5426.864328391822;5500.669959802424;5520.834374968757;5612;5504.394516603171;5508.614396992252;5511.862203444946;5512.0905050667;5546.722663866791;5513.889722205534;5517.5585953123655;5522.723863806794;5523.889522209533;5573.832785016456;4180.770057646798;4198.286291330481;4225.471816022997;4249.426327445817;4325.589069038437;3764.3036038333;3784.6404591563755;3811.951713278815;3830.674392676598;3855.9807200963814;5189;5217.869553261123;5225.555827754683;5228.503292187236;5229.47705229474;5397.703126328011;5491.36849262332;5506.504414602705;5511.421300763443;5533.170024496278;5342.065138600729;5382.515573598395;5389.541888939484;5427.402985671573;5444.618876678674;4848.200046992278;4862.440819305825;4863.878403039882;4865.391826021747;4907.141250281186;5621.831345059655;5834.941650583524;5911.4975227105315;5920.052791553331;5924.052151655715;5590.5527557796095;5649.971750141223;5650.3219613646625;5695.117256825199;5706.172604972338;5820.30156381237;5846.327672317738;5852.7658893643775;5867.178594996619;5939.049752039653;5267.130923397596;5376.784928602812;5492.368377636463;5538.556915446674;5541.418151094077;5492.835214943558;5555.638883472561;5560.27716396882;5610;5612.579056570855;5394.433584473573;5435.728213589226;5436.7281635918835;5440.972795135999;5441.700706461183;5351.063563876384;5419.864503387289;5425.213344065168;5444.972775136099;5477.643953143033;5398.217258497574;5441.129419292894;5444.183372494158;5486.725663716878;5493.725313734377;5503.174523821459;5541.058020136506;5544.334679838284;5579.497845193952;5582.804601838916;5266.183741520071;5318.388385335581;5414.648047876875;5421.430749771217;5421.593380496557 16:24:58 INFO - PROCESS | 23970 | |1;ext.html;556.2779238808452;586.9911951320731;596.0820336681513;596.201090538678;610.9949133675104;32927.34145317092;33484;35782.82108589453;35807.820960895195;35863.82068089662;45875.77062114685;46664;46745.99999999991;50469.24296135561;50546.24180637284;8945.10548945105;9041.593128309209;9074.455532668027;9079.273658107368;9082.772930676752;8959.955200223989;8967.641294348217;8985.685501007467;9013.32400069994;9070.954645226764;9016.008239093695;9032.367734258605;9055.501947392891;9061.818763624757;9064.549672052473;8961.820763584725;9015.639374425014;9018.36871419001;9031.096890310917;9032.27741780656;8900.51047192404;8939.553022348922;8945.105489451067;8963.238124759404;8968.820623587557;44881.32678009832;45067.54932450666;45256.77371613154;45356;45381;3723.925521489582;3803;3889.6888248940018;3920.333543297618;4097;33260.50109248363;33991.320173596636;34125.48811767826;34131.658683413094;35834.28331433383;4298.570142985708;4375.124975005012;4383.912321753579;4576.519465456113;4627.838025669085;372760;373416;374618;374994;375676;60971;61631.69184154051;61636.69181654063;61661.383386165566;61723.38276617266;55063;65864.6706766463;66098.33901660921;66129.66935165293;66135;15685.764713529306;16158.59603509898;16277.430289939795;16564.585885352964;16583.50249492493;11999.280043197436;12040;12050;12051.156419050581;12066.457009434596;16266.67466650684;18759.531011724543;18772.249110035445;18789.718154227696;18876.24495020211;6855.5543889647015;6889.931100688929;6934.549254298556;7031.156261248683;7174.31843974832;911.3256190419042;956.818204541135;970.3256236915277;1008.1078245752561;1058.3914249306679;33974.83012584971;34010.31979360448;34125.317493649985;34306;34345;1044.6343779677052;1063.2025980514613;1083.4980655376921;1097.3306283167262;1109.3011402816173;17321.480355589352;17582.912085439748;17607.647847043245;17701.38045168413;17837.10814459272;556124;562143;563404;563875;565746;62115;62317.37682623207;62323;62389.376106239266;62415;1304.1001708820884;1323.3780123341821;1325.8607846176205;1333.7732585460494;1348.0698318160437;31520.369592608477;32421.837890810395;32985.67014329826;33011.33977320488;33260;54643.18035229395;55062.449375507334;55129.72435137798;55130.44869551253;55218.44781552133;451791;452506;452959;455338;456792;33064.33871322512;38037.80981095077;38052;41325.586744132175;44851.32723009092;44520.33219501645;49724.25413618871;50043.49956500534;51068;51796.89218646893;41315.586844131176;43097;43486;43982.78008609937;44331.77834110809;42329.57670423256;42485.36271955985;42627.3605895918;43423.565764341954;44134.55865441304;41862.37206441845;42715.5728442724;42960.35559466548;43583.56416435795;46665.30002049904;33390.33219335648;38763.80618096892;39018.414723778595;39092.6090739089;39933.80033099816;29477.705222948352;29671.70328296776;29965.55051674183;30031.849840750656;30061.549076764302 16:24:58 INFO - PROCESS | 23970 | |2;jquery.html;360.2434886737849;369.18226129123985;369.2356821379745;375.6750410894577;391.9784411857348;14600.488982885588;18700.345487907907;19876.40370788875;20407.795922040776;20433.795662043376;18654.440366788986;18921.337753178643;20047.799522004774;20232.39302820918;20236.29172978946;5104.591632669396;5328.893422131555;5334.973325133369;5335.493128152839;5336.252924590561;5211.062008838408;5276.577873770089;5869.2369991901;5899;5900;5870.677112758796;5871.618344807595;5876.147958546008;5876.177335173079;5878.588498805086;5256.3955145158225;5274.235235890775;5280.2079688046715;5283.762230699608;5582.385937546866;5147.716875571842;5149.6910185389;5150.845474635767;5151.304573882516;5157.871053223662;13498.595042148652;14606.926965365212;21590.784092159036;24433.877830610734;24613.87693061541;2122.607317646225;2346.6597343385283;2379.654950032236;2398.2085911649115;2870.4833130036586;9918.156956658693;10304.227182961307;10319.380837149794;13074.803877941744;14485.348159332856;1945.6400565895212;1977.713231581427;2033.7254470646421;2064.1227478321653;2115.6826476028564;83413.58293208556;87434.8193439686;87458.56270718605;88094.55952720196;88220.55889720574;10782.892171078189;11355.375454349925;11593.88406115945;11625.24435911663;11674.416279186007;16326.75509867353;16356.509304720877;16358.182090895407;16368;16380.180990950405;8086.312663423557;8088.352931765445;8242.29940455056;8285.50286982783;8472.534010629475;7488.588127653032;7569.962150189324;7616.581088040211;7765.990421245202;7793.2596403341595;4486.214912390384;4726.243800991825;4743.644226683013;4979.502049794992;5119.74401279942;1892.224188082907;2007.6787713965696;2043.3461292386294;2089.5298557824367;2125.1818050050842;911.4303560274828;940.8870935487786;1024.3853687787268;1032.1175395037135;1057.0656493403299;20149.294774682814;21021;21175.258865939617;21187.470313241985;21203.575928481343;992.6476100984047;1012.5899010900597;1028.1055481730941;1087.4494774561065;1111.8443417921496;10852.94573527143;11559.76880462386;11661.416929153509;11817.290962542274;11860.94069529664;367851;368093.0311620392;372081;453594;496656;74176.62911685408;75482;91984.54007729919;96945.5152724246;97390;984.060222487537;985.1576901749045;1007.561710655867;1026.343140390151;1027.3117011602244;18210.72683909716;18681.53296167607;19134.904325478285;19356;19462.513437164183;40538.18923621452;42064.53285730689;44740.77629611831;44901.10197796091;45409.31886021778;60278.397216027275;60635.69682151561;61049.694751527735;62071;62645;8156.8368632625825;8202.220789025034;8285.295749861329;8382.119877412784;8601.22588966996;12347.62957111288;13102.737945241233;13449.46202151903;13480.595582132551;13573.59279221625;11298.209125361145;11626.941865290619;11677.357745323749;11907.821382679094;11999.82000270014;10955.123590112613;11116.11071114325;11222.326660400402;11343.376114313793;11813.881861181279;10814.837777433502;10833.566657333618;10869.891301086887;10968.616098436516;11573.537058517564;8037.397195210499;8195.95902020486;8268.710595129141;8394.538300393293;8859.06979767115;9406.467008472064;11207.775844483227;11327.207095503565;11543.595974140864;11833.704157396134 16:24:58 INFO - PROCESS | 23970 | |3;mootools.html;1458.4968185975838;1505.6687528743676;1614.6367067409835;1754.175537497376;1778.866585006124;8160.591970401486;8726.781830454234;8735.38852280339;8736.475811451317;8742.344324175681;7402.814929626762;7584.582847943361;7616.162222155558;7802.258785415391;8578.571071446433;2312.90748370065;2395.185636883459;2399.172285561487;2409.915652952147;2419.0565679385054;2370.7747763962398;2395.9760402395927;2414.5050264695697;2418.733939266688;2422.685050943375;2331.090874558915;2334.6848175496343;2337.4390146364835;2339.8479098858606;2341.0869760793303;2300.9654855177187;2347.213683416049;2348.1194552042984;2350.6239001759723;2355.1050600771596;2278.487340348425;2284.9543009139725;2291.2782473520956;2291.5989701802287;2299.229758031045;8672.826543469095;8755.430896991675;8760.912390876138;8763.693270735494;8764.517951512664;5136.280920671072;5273.894522109536;5274.709890955995;5275.657082289639;5279.498447647467;3209.0854106579745;3301.735861131104;3316.303576248991;3322.3355328934067;3335.299587086715;1012.817692815293;1053.083817079146;1061.930974486656;1066.62668066177;1069.9304545204614;12109.33398663082;12123.878761212363;12125.09061820367;12135.696607584881;12145.635630930998;4260.467441569804;4437.889052773707;4651.767411629473;4651.790669419885;4655.86032419028;10225;10271.794564108675;10301.381917084998;10318.071373576415;10327.535260913277;5261.76322065508;5283.286756287929;5285.55072818807;5291.603129765206;5292.497212764782;4800.975995120002;4865.829695960695;4867.9269810952865;4870.245112007645;4878.804847806119;3931.4299426582984;3988.8205030773684;4026.134381108076;4073.5315438724924;4131.338985762263;1258.79229927061;1262.5581046633788;1293.3080801771007;1307.9215247085206;1313.1398933698442;906.6056265524518;925.8240934222476;944.7812322104409;947.4646824544249;976.4043933200742;5471.480209380182;5541.085720856095;5762.625429347079;5778.682172480554;5791.971040144772;887.2059506741431;902.9413088149249;955.8852937647526;957.7988622389237;970.9854352184723;3882.5340959085092;3965.6827453803626;4038.9394159087637;4099.97950010254;4101.8974525637095;10468.790624187473;10830.296030757976;10845.51195196218;10882.67351979426;10921.290116142425;10025.097741203326;10353.223508236912;10354.637587684394;10365.170786337076;10815.621453249098;7764.340031097307;7972.84054318922;7976.840463190703;8119.431639785158;8126.9593652032545;5545.944540554543;5584.441555844545;5738.512226460798;5756.802042607603;5896.616719913192;9699.709008729467;10075;10117.747056323651;10184.796304074025;10276.434796086287;10148.949255253972;10205.795884082128;10208.59165633396;10214.131798797185;10237.232207584311;7518.699252029857;8136.633851476579;8285.95857020711;8365.456245344034;8543.957280213559;8546.658133674584;8554.401191916506;8620.482771033758;8629.827403452022;8643.265322447662;7356.411487081128;7468.626568671436;7622.69509219625;7637.198094200251;7843.137254902071;7263.0921134858145;7375.815604609713;7505.66224519887;7534.886976695464;7568.243175682388;6666.266710661726;6768.7292508299115;6778.118844550374;6780.593164410151;6785.287544807724;4886.53577910098;4933.136701077369;5066.670666406671;5098.260752190838;5285.762140703754;5025.773840177128;5095.92356114666;5164;5266.578673706018;5315.388730295911 16:24:58 INFO - PROCESS | 23970 | |4;prototype.html;307.5955119018491;316.8970084722463;318.77048525061946;323.3452259175171;332.5942350332594;5066.594672426207;5087.847364579059;5099.133147364948;5110.897782044357;5140.1518749406305;5048.6465947383695;5049.3940727112795;5068.67053641513;5102.413222479416;5109.437961824206;4073.287174744423;4076.388541718736;4078.3678529827926;4083.5099788025477;4093.546790889236;3949.2299001694537;4054.6350828425434;4071.2875246831686;4087.6934229932726;4088.5911408859174;4034.314166591672;4036.132231570212;4045.2111838191563;4055.918881622366;4064.1871625674985;3841.5414134953653;4030.2342554914617;4056.675465962716;4058.1883623275166;4075.735077219986;3479.6868281854754;3599.6400359964055;3617.113807117273;3622.855085796565;3631.763935344194;4945;4954.2568614707725;4960.718069687948;4964.60283177345;4974.403071631391;4314.80583373749;4586.793594288265;4600.4479462464715;4605.34207685233;4616.238320677085;5039.949600503985;5101.63292227132;5211.452797456251;5225.921611175835;5275.683458992473;3862.2854771867296;3864.401017842239;3871.457995880579;3871.9419208711893;3879.1659793144327;5325.520703136697;5456.563474921997;5469.343678758574;5469.507744302992;5486.1222204447495;3946.743461674982;3969.166475040274;3975.3043217436834;3977.8607748728655;3996.140829721624;4011.2378648056774;4020.336644453691;4029.234445455354;4031.536373317106;4037.6769858411258;4535.206338890747;4537.410136682276;4539.296409056601;4567.634589232854;4572.833927348572;5176.663516871391;5212.83667278083;5305.620538659976;5338.519533242027;5345.198220266913;1400.9439622414989;1415.773476243796;1417.9082106777723;1418.687713864671;1421.4243231491262;891.4027601507006;927.2165020557618;932.6662872092837;938.9812203755887;940.4827344960381;4503.774811259424;4605.355250264965;4608.340997240991;4660.254359302563;4670.299455081765;4821.035063435962;4823.252395878644;4823.662343635982;4824.517548245148;4860.902781944412;4358.694891357574;4564.543545645475;4603.654725895572;4627.190241707688;4664.976675116603;2535.404180017694;2543.5421624107466;2572.5755250383477;2736.6031925370708;2804.144735855584;5648.74580643872;5665.858353541112;5670.06443936754;5671.432856714296;5677.205191273225;5465.234867118606;5466.590005749585;5481.835544933659;5505.862353441116;5516.503514683617;5429.4299098594865;5688.715564221855;5703.344115426696;5713.171590119409;5723.198752174782;5411.729413529387;5460.453954604666;5471.124620060771;5484.177373394023;5493.340799103973;5160.793568257228;5365.812196573102;5373.623846330719;5403.756830942539;5441.238226648352;5671.716414179357;5751.9424805751405;5785.768569257182;5786;5799.4780469757925;3944.526656801202;3960.168364643457;3974.1058261890844;3979.164375481181;3988.680905527493;5256.159014557652;5440.700761458158;5492.670439773627;5499.807506737245;5504.9449505504435;5331.600129990189;5344.599155063308;5349.839504814861;5351.60858176869;5359.785608575613;5263.73681315925;5331.440198779227;5333.7866485340155;5348.705821179872;5348.786048558014;5028.446870844277;5235.842924712265;5277.102892508359;5299.258103865539;5299.364076310867;5363.674521796511;5370.758315875717;5374.6506477078865;5378.300820893259;5396.406395296593;5237.6333656643665;5247.291615631993;5280.577553795611;5288.22844347148;5288.3918349390315 16:24:58 INFO - PROCESS | 23970 | |5;yui.html;670.4234358451733;685.8593988232412;719.2591630620461;724.0334153904537;756.1304499825201;14734.18961957092;15591.84408155918;15635.374585016585;15735.527934161964;15799.28903199356;15199.32807391186;15566.221688915566;15571.844281557182;15581.766273505906;15602.609934751608;658.2134349452406;784.2432053068787;810.9594520273993;811.419834818105;826.4338927834423;815.2744057788573;826.0335407573153;826.1366871619142;826.4958375391006;829.2329595124515;876.045110829196;880.1682410122437;881.1408876345575;881.8853549038616;882.0429833630518;691.9100516932791;849.4351256414539;870.525563567857;876.0363600039937;876.583622779178;637.3912913167914;637.611057255074;637.6492928889139;637.7544645311542;637.7831537277348;13656.24890631015;13674.31628418585;13680.726385472235;13689.520866769715;13692.794608080887;14202.573922782332;14716.55850324492;14941.252937353089;14994.775078373834;15070.924645376703;13236.735265294736;13451.86548134516;13465.192088474723;13477.730445391135;13495.392707328194;4423.623991960687;4443.133588950156;4452.30989196675;4534.13851368239;4604.079184163181;84733;85063.5746821262;85571.14428855757;86146.56926715389;88105.55947220288;11439.84023964054;11477.54089836414;11525.76948461026;11573.826392603949;11732.882671173178;21996.780032199793;22015.449613759785;22053.558928821334;22069.889650551646;22091;8431.704890328809;8535.231829135408;8611.655533778703;8633.827323453495;8984.101589840964;4680.672352935262;4824.107540105092;4861.319415281863;4894.458245652608;5006.07387633289;3389.9661003390142;3501.1072176594807;3522.577290725078;3528.3119791640897;3530.064532898784;604.3050491934223;618.1006635345561;627.9246490421178;629.0407129128025;636.4208570201095;596.9910451343234;676.8578598494273;701.4809041309394;717.7093277222733;720.4704542161508;9430.3398762086;9775.364601301035;9851.211903047739;10162.695119146438;10206.489675516343;664.9035889795953;669.8593295408019;686;689.4941556925468;712.5190496415003;4543.454785425704;4593.753247845889;4732.313814496879;4807.759612019385;4908.509149085135;74233.62883185658;75032.24967750361;75231.62384188044;103448;126829;107074;108006;108369;108766.45616771866;115314;79171;80511;80594.99999999882;95276;95402.52298738463;9517.857232141661;10395.32430392022;10485.37087774736;10495.107915826935;10572.101371383518;46602.766986164854;49104.263436047775;49245;50927.236091459396;51710.60459860954;69180.6540967292;70155;74951.62524187344;75308.62345688237;77592.61203693945;13344.799828002782;13364.665883352995;13523.932380338036;13570.660733481347;13977.371018304404;14547.781783273047;14636.926815365856;14698.338574763948;14933.850661493247;15256.389744410544;13491.865081349453;13630.182189068688;13635.86364136346;14303.499377521737;14767.261636917896;14244.643883902985;14723.411063557338;14745.557633271019;14943.327550260481;15073.246337682853;13935.651608709457;14176.858231417966;14295.714085718435;14799.408023678932;14871;11300.660980170607;11308.547658093585;11777.646670599896;11988.580399685969;12035;11120.777584448428;11447.797981212187;11803.586874459354;12288.631341059783;12369.072319575887 16:24:58 INFO - PROCESS | 23970 | __end_tp_report 16:24:58 INFO - PROCESS | 23970 | __start_cc_report 16:24:58 INFO - PROCESS | 23970 | _x_x_mozilla_cycle_collect,1058 16:24:58 INFO - PROCESS | 23970 | __end_cc_report 16:24:58 INFO - PROCESS | 23970 | __startTimestamp1470093898237__endTimestamp 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | ------- Summary: start ------- 16:24:58 INFO - PROCESS | 23970 | Number of tests: 6 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | [#0] dojo.html Cycles:165 Average:5184.94 Median:5414.65 stddev:592.33 (10.9%) stddev-sans-first:568.20 16:24:58 INFO - PROCESS | 23970 | Values: 2974.6 2976.1 2995.3 3007.3 3031.3 5094.9 5143.9 5161.1 5170.9 5222.3 5186.6 5200.6 5243.6 5246.9 5254.8 4741.7 4760.4 4768.3 4772.2 4866.0 4780.7 4813.2 4815.0 4824.0 4835.3 4536.8 4588.7 4745.8 4808.6 4815.3 4719.3 4724.1 4730.8 4797.9 4847.9 4773.4 4778.5 4785.9 4796.5 4807.3 5057.4 5112.5 5245.9 5264.9 5289.4 5507.8 5545.9 5546.4 5549.9 5551.2 5569.9 5594.4 5610.6 5611.0 5615.0 5008.4 5095.4 5147.9 5179.4 5211.3 5707.4 5741.1 5742.2 5742.8 5748.3 5517.1 5526.7 5527.5 5528.6 5530.7 5353.8 5426.9 5500.7 5520.8 5612.0 5504.4 5508.6 5511.9 5512.1 5546.7 5513.9 5517.6 5522.7 5523.9 5573.8 4180.8 4198.3 4225.5 4249.4 4325.6 3764.3 3784.6 3812.0 3830.7 3856.0 5189.0 5217.9 5225.6 5228.5 5229.5 5397.7 5491.4 5506.5 5511.4 5533.2 5342.1 5382.5 5389.5 5427.4 5444.6 4848.2 4862.4 4863.9 4865.4 4907.1 5621.8 5834.9 5911.5 5920.1 5924.1 5590.6 5650.0 5650.3 5695.1 5706.2 5820.3 5846.3 5852.8 5867.2 5939.0 5267.1 5376.8 5492.4 5538.6 5541.4 5492.8 5555.6 5560.3 5610.0 5612.6 5394.4 5435.7 5436.7 5441.0 5441.7 5351.1 5419.9 5425.2 5445.0 5477.6 5398.2 5441.1 5444.2 5486.7 5493.7 5503.2 5541.1 5544.3 5579.5 5582.8 5266.2 5318.4 5414.6 5421.4 5421.6 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | [#1] ext.html Cycles:180 Average:63248.84 Median:44058.67 stddev:124567.06 (282.7%) stddev-sans-first:124827.57 16:24:58 INFO - PROCESS | 23970 | Values: 556.3 587.0 596.1 596.2 611.0 32927.3 33484.0 35782.8 35807.8 35863.8 45875.8 46664.0 46746.0 50469.2 50546.2 8945.1 9041.6 9074.5 9079.3 9082.8 8960.0 8967.6 8985.7 9013.3 9071.0 9016.0 9032.4 9055.5 9061.8 9064.5 8961.8 9015.6 9018.4 9031.1 9032.3 8900.5 8939.6 8945.1 8963.2 8968.8 44881.3 45067.5 45256.8 45356.0 45381.0 3723.9 3803.0 3889.7 3920.3 4097.0 33260.5 33991.3 34125.5 34131.7 35834.3 4298.6 4375.1 4383.9 4576.5 4627.8 372760.0 373416.0 374618.0 374994.0 375676.0 60971.0 61631.7 61636.7 61661.4 61723.4 55063.0 65864.7 66098.3 66129.7 66135.0 15685.8 16158.6 16277.4 16564.6 16583.5 11999.3 12040.0 12050.0 12051.2 12066.5 16266.7 18759.5 18772.2 18789.7 18876.2 6855.6 6889.9 6934.5 7031.2 7174.3 911.3 956.8 970.3 1008.1 1058.4 33974.8 34010.3 34125.3 34306.0 34345.0 1044.6 1063.2 1083.5 1097.3 1109.3 17321.5 17582.9 17607.6 17701.4 17837.1 556124.0 562143.0 563404.0 563875.0 565746.0 62115.0 62317.4 62323.0 62389.4 62415.0 1304.1 1323.4 1325.9 1333.8 1348.1 31520.4 32421.8 32985.7 33011.3 33260.0 54643.2 55062.4 55129.7 55130.4 55218.4 451791.0 452506.0 452959.0 455338.0 456792.0 33064.3 38037.8 38052.0 41325.6 44851.3 44520.3 49724.3 50043.5 51068.0 51796.9 41315.6 43097.0 43486.0 43982.8 44331.8 42329.6 42485.4 42627.4 43423.6 44134.6 41862.4 42715.6 42960.4 43583.6 46665.3 33390.3 38763.8 39018.4 39092.6 39933.8 29477.7 29671.7 29965.6 30031.8 30061.5 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | [#2] jquery.html Cycles:180 Average:27013.20 Median:24523.88 stddev:69063.32 (281.6%) stddev-sans-first:69228.07 16:24:58 INFO - PROCESS | 23970 | Values: 360.2 369.2 369.2 375.7 392.0 14600.5 18700.3 19876.4 20407.8 20433.8 18654.4 18921.3 20047.8 20232.4 20236.3 5104.6 5328.9 5335.0 5335.5 5336.3 5211.1 5276.6 5869.2 5899.0 5900.0 5870.7 5871.6 5876.1 5876.2 5878.6 5256.4 5274.2 5280.2 5283.8 5582.4 5147.7 5149.7 5150.8 5151.3 5157.9 13498.6 14606.9 21590.8 24433.9 24613.9 2122.6 2346.7 2379.7 2398.2 2870.5 9918.2 10304.2 10319.4 13074.8 14485.3 1945.6 1977.7 2033.7 2064.1 2115.7 83413.6 87434.8 87458.6 88094.6 88220.6 10782.9 11355.4 11593.9 11625.2 11674.4 16326.8 16356.5 16358.2 16368.0 16380.2 8086.3 8088.4 8242.3 8285.5 8472.5 7488.6 7570.0 7616.6 7766.0 7793.3 4486.2 4726.2 4743.6 4979.5 5119.7 1892.2 2007.7 2043.3 2089.5 2125.2 911.4 940.9 1024.4 1032.1 1057.1 20149.3 21021.0 21175.3 21187.5 21203.6 992.6 1012.6 1028.1 1087.4 1111.8 10852.9 11559.8 11661.4 11817.3 11860.9 367851.0 368093.0 372081.0 453594.0 496656.0 74176.6 75482.0 91984.5 96945.5 97390.0 984.1 985.2 1007.6 1026.3 1027.3 18210.7 18681.5 19134.9 19356.0 19462.5 40538.2 42064.5 44740.8 44901.1 45409.3 60278.4 60635.7 61049.7 62071.0 62645.0 8156.8 8202.2 8285.3 8382.1 8601.2 12347.6 13102.7 13449.5 13480.6 13573.6 11298.2 11626.9 11677.4 11907.8 11999.8 10955.1 11116.1 11222.3 11343.4 11813.9 10814.8 10833.6 10869.9 10968.6 11573.5 8037.4 8196.0 8268.7 8394.5 8859.1 9406.5 11207.8 11327.2 11543.6 11833.7 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | [#3] mootools.html Cycles:180 Average:5723.24 Median:4866.88 stddev:3230.36 (66.4%) stddev-sans-first:3223.53 16:24:58 INFO - PROCESS | 23970 | Values: 1458.5 1505.7 1614.6 1754.2 1778.9 8160.6 8726.8 8735.4 8736.5 8742.3 7402.8 7584.6 7616.2 7802.3 8578.6 2312.9 2395.2 2399.2 2409.9 2419.1 2370.8 2396.0 2414.5 2418.7 2422.7 2331.1 2334.7 2337.4 2339.8 2341.1 2301.0 2347.2 2348.1 2350.6 2355.1 2278.5 2285.0 2291.3 2291.6 2299.2 8672.8 8755.4 8760.9 8763.7 8764.5 5136.3 5273.9 5274.7 5275.7 5279.5 3209.1 3301.7 3316.3 3322.3 3335.3 1012.8 1053.1 1061.9 1066.6 1069.9 12109.3 12123.9 12125.1 12135.7 12145.6 4260.5 4437.9 4651.8 4651.8 4655.9 10225.0 10271.8 10301.4 10318.1 10327.5 5261.8 5283.3 5285.6 5291.6 5292.5 4801.0 4865.8 4867.9 4870.2 4878.8 3931.4 3988.8 4026.1 4073.5 4131.3 1258.8 1262.6 1293.3 1307.9 1313.1 906.6 925.8 944.8 947.5 976.4 5471.5 5541.1 5762.6 5778.7 5792.0 887.2 902.9 955.9 957.8 971.0 3882.5 3965.7 4038.9 4100.0 4101.9 10468.8 10830.3 10845.5 10882.7 10921.3 10025.1 10353.2 10354.6 10365.2 10815.6 7764.3 7972.8 7976.8 8119.4 8127.0 5545.9 5584.4 5738.5 5756.8 5896.6 9699.7 10075.0 10117.7 10184.8 10276.4 10148.9 10205.8 10208.6 10214.1 10237.2 7518.7 8136.6 8286.0 8365.5 8544.0 8546.7 8554.4 8620.5 8629.8 8643.3 7356.4 7468.6 7622.7 7637.2 7843.1 7263.1 7375.8 7505.7 7534.9 7568.2 6666.3 6768.7 6778.1 6780.6 6785.3 4886.5 4933.1 5066.7 5098.3 5285.8 5025.8 5095.9 5164.0 5266.6 5315.4 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | [#4] prototype.html Cycles:180 Average:4455.70 Median:5034.20 stddev:1296.17 (25.7%) stddev-sans-first:1261.86 16:24:58 INFO - PROCESS | 23970 | Values: 307.6 316.9 318.8 323.3 332.6 5066.6 5087.8 5099.1 5110.9 5140.2 5048.6 5049.4 5068.7 5102.4 5109.4 4073.3 4076.4 4078.4 4083.5 4093.5 3949.2 4054.6 4071.3 4087.7 4088.6 4034.3 4036.1 4045.2 4055.9 4064.2 3841.5 4030.2 4056.7 4058.2 4075.7 3479.7 3599.6 3617.1 3622.9 3631.8 4945.0 4954.3 4960.7 4964.6 4974.4 4314.8 4586.8 4600.4 4605.3 4616.2 5039.9 5101.6 5211.5 5225.9 5275.7 3862.3 3864.4 3871.5 3871.9 3879.2 5325.5 5456.6 5469.3 5469.5 5486.1 3946.7 3969.2 3975.3 3977.9 3996.1 4011.2 4020.3 4029.2 4031.5 4037.7 4535.2 4537.4 4539.3 4567.6 4572.8 5176.7 5212.8 5305.6 5338.5 5345.2 1400.9 1415.8 1417.9 1418.7 1421.4 891.4 927.2 932.7 939.0 940.5 4503.8 4605.4 4608.3 4660.3 4670.3 4821.0 4823.3 4823.7 4824.5 4860.9 4358.7 4564.5 4603.7 4627.2 4665.0 2535.4 2543.5 2572.6 2736.6 2804.1 5648.7 5665.9 5670.1 5671.4 5677.2 5465.2 5466.6 5481.8 5505.9 5516.5 5429.4 5688.7 5703.3 5713.2 5723.2 5411.7 5460.5 5471.1 5484.2 5493.3 5160.8 5365.8 5373.6 5403.8 5441.2 5671.7 5751.9 5785.8 5786.0 5799.5 3944.5 3960.2 3974.1 3979.2 3988.7 5256.2 5440.7 5492.7 5499.8 5504.9 5331.6 5344.6 5349.8 5351.6 5359.8 5263.7 5331.4 5333.8 5348.7 5348.8 5028.4 5235.8 5277.1 5299.3 5299.4 5363.7 5370.8 5374.7 5378.3 5396.4 5237.6 5247.3 5280.6 5288.2 5288.4 16:24:58 INFO - PROCESS | 23970 | 16:24:58 INFO - PROCESS | 23970 | [#5] yui.html Cycles:180 Average:20834.32 Median:4493.22 stddev:29505.97 (656.7%) stddev-sans-first:29549.90 16:24:58 INFO - PROCESS | 23970 | Values: 670.4 685.9 719.3 724.0 756.1 14734.2 15591.8 15635.4 15735.5 15799.3 15199.3 15566.2 15571.8 15581.8 15602.6 658.2 784.2 811.0 811.4 826.4 815.3 826.0 826.1 826.5 829.2 876.0 880.2 881.1 881.9 882.0 691.9 849.4 870.5 876.0 876.6 637.4 637.6 637.6 637.8 637.8 13656.2 13674.3 13680.7 13689.5 13692.8 14202.6 14716.6 14941.3 14994.8 15070.9 13236.7 13451.9 13465.2 13477.7 13495.4 4423.6 4443.1 4452.3 4534.1 4604.1 84733.0 85063.6 85571.1 86146.6 88105.6 11439.8 11477.5 11525.8 11573.8 11732.9 21996.8 22015.4 22053.6 22069.9 22091.0 8431.7 8535.2 8611.7 8633.8 8984.1 4680.7 4824.1 4861.3 4894.5 5006.1 3390.0 3501.1 3522.6 3528.3 3530.1 604.3 618.1 627.9 629.0 636.4 597.0 676.9 701.5 717.7 720.5 9430.3 9775.4 9851.2 10162.7 10206.5 664.9 669.9 686.0 689.5 712.5 4543.5 4593.8 4732.3 4807.8 4908.5 74233.6 75032.2 75231.6 103448.0 126829.0 107074.0 108006.0 108369.0 108766.5 115314.0 79171.0 80511.0 80595.0 95276.0 95402.5 9517.9 10395.3 10485.4 10495.1 10572.1 46602.8 49104.3 49245.0 50927.2 51710.6 69180.7 70155.0 74951.6 75308.6 77592.6 13344.8 13364.7 13523.9 13570.7 13977.4 14547.8 14636.9 14698.3 14933.9 15256.4 13491.9 13630.2 13635.9 14303.5 14767.3 14244.6 14723.4 14745.6 14943.3 15073.2 13935.7 14176.9 14295.7 14799.4 14871.0 11300.7 11308.5 11777.6 11988.6 12035.0 11120.8 11447.8 11803.6 12288.6 12369.1 16:24:58 INFO - PROCESS | 23970 | -------- Summary: end -------- 16:24:58 INFO - PROCESS | 23970 | 16:24:59 INFO - TEST-INFO | 23970: exit 0 16:24:59 INFO - TEST-OK | dromaeo_css | took 1114569ms 16:24:59 INFO - TEST-START | kraken 16:24:59 INFO - operating with platform_type : linux_ 16:24:59 INFO - Initialising browser for kraken test... 16:24:59 INFO - TEST-INFO | started process 24169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcR1CI/profile http://localhost:40544/getInfo.html) 16:25:03 INFO - PROCESS | 24169 | __metrics Screen width/height:1600/1200 16:25:03 INFO - PROCESS | 24169 | colorDepth:24 16:25:03 INFO - PROCESS | 24169 | Browser inner width/height: 1024/697 16:25:03 INFO - PROCESS | 24169 | __metrics 16:25:04 INFO - PROCESS | 24169 | 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" 16:25:04 INFO - PROCESS | 24169 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:25:05 INFO - TEST-INFO | 24169: exit 0 16:25:05 INFO - Browser initialized. 16:25:05 INFO - Running cycle 1/1 for kraken test... 16:25:05 INFO - TEST-INFO | started process 24246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcR1CI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:16 INFO - PROCESS | 24246 | RSS: Main: 155578368 16:25:16 INFO - PROCESS | 24246 | 16:25:19 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40544/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:20 INFO - PROCESS | 24246 | RSS: Main: 212422656 16:25:20 INFO - PROCESS | 24246 | 16:25:22 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40544/tests/kraken/driver.html?testName=audio-dft) 16:25:23 INFO - PROCESS | 24246 | RSS: Main: 190316544 16:25:23 INFO - PROCESS | 24246 | 16:25:26 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40544/tests/kraken/driver.html?testName=audio-fft) 16:25:27 INFO - PROCESS | 24246 | RSS: Main: 269570048 16:25:27 INFO - PROCESS | 24246 | 16:25:29 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40544/tests/kraken/driver.html?testName=audio-oscillator) 16:25:29 INFO - PROCESS | 24246 | RSS: Main: 179150848 16:25:29 INFO - PROCESS | 24246 | 16:25:32 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:32 INFO - PROCESS | 24246 | RSS: Main: 183726080 16:25:32 INFO - PROCESS | 24246 | 16:25:35 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40544/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:36 INFO - PROCESS | 24246 | RSS: Main: 218771456 16:25:36 INFO - PROCESS | 24246 | 16:25:39 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40544/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:40 INFO - PROCESS | 24246 | RSS: Main: 218828800 16:25:40 INFO - PROCESS | 24246 | 16:25:43 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40544/tests/kraken/driver.html?testName=json-parse-financial) 16:25:43 INFO - PROCESS | 24246 | RSS: Main: 218886144 16:25:43 INFO - PROCESS | 24246 | 16:25:45 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:45 INFO - PROCESS | 24246 | RSS: Main: 183533568 16:25:45 INFO - PROCESS | 24246 | 16:25:47 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:48 INFO - PROCESS | 24246 | RSS: Main: 188215296 16:25:48 INFO - PROCESS | 24246 | 16:25:50 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:50 INFO - PROCESS | 24246 | RSS: Main: 194195456 16:25:50 INFO - PROCESS | 24246 | 16:25:53 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:54 INFO - PROCESS | 24246 | RSS: Main: 187695104 16:25:54 INFO - PROCESS | 24246 | 16:25:56 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:25:57 INFO - PROCESS | 24246 | RSS: Main: 191713280 16:25:57 INFO - PROCESS | 24246 | 16:25:58 INFO - PROCESS | 24246 | Cycle 1(1): loaded http://localhost:40544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40544/tests/kraken/driver.html?testName=ai-astar) 16:25:59 INFO - PROCESS | 24246 | RSS: Main: 243257344 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | __start_tp_report 16:25:59 INFO - PROCESS | 24246 | _x_x_mozilla_page_load 16:25:59 INFO - PROCESS | 24246 | _x_x_mozilla_page_load_details 16:25:59 INFO - PROCESS | 24246 | |i|pagename|runs| 16:25:59 INFO - PROCESS | 24246 | |0;ai-astar;105;112;110;110;112;111;111;112;112;110 16:25:59 INFO - PROCESS | 24246 | |1;audio-beat-detection;147;118;121;177;119;120;148;117;153;118 16:25:59 INFO - PROCESS | 24246 | |2;audio-dft;160;160;163;161;161;160;161;162;161;162 16:25:59 INFO - PROCESS | 24246 | |3;audio-fft;76;76;77;104;76;76;74;75;114;74 16:25:59 INFO - PROCESS | 24246 | |4;audio-oscillator;84;85;118;84;84;84;126;83;84;143 16:25:59 INFO - PROCESS | 24246 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 16:25:59 INFO - PROCESS | 24246 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;147;145 16:25:59 INFO - PROCESS | 24246 | |7;imaging-desaturate;95;95;95;95;94;95;94;96;95;95 16:25:59 INFO - PROCESS | 24246 | |8;json-parse-financial;49;50;50;50;49;50;50;50;49;49 16:25:59 INFO - PROCESS | 24246 | |9;json-stringify-tinderbox;60;61;60;61;61;60;61;61;62;60 16:25:59 INFO - PROCESS | 24246 | |10;stanford-crypto-aes;81;77;75;75;76;76;76;76;76;82 16:25:59 INFO - PROCESS | 24246 | |11;stanford-crypto-ccm;124;122;122;120;119;131;131;122;176;134 16:25:59 INFO - PROCESS | 24246 | |12;stanford-crypto-pbkdf2;160;158;161;158;171;165;162;158;159;162 16:25:59 INFO - PROCESS | 24246 | |13;stanford-crypto-sha256-iterative;63;63;64;63;65;64;62;64;62;60 16:25:59 INFO - PROCESS | 24246 | __end_tp_report 16:25:59 INFO - PROCESS | 24246 | __start_cc_report 16:25:59 INFO - PROCESS | 24246 | _x_x_mozilla_cycle_collect,1674 16:25:59 INFO - PROCESS | 24246 | __end_cc_report 16:25:59 INFO - PROCESS | 24246 | __startTimestamp1470093959251__endTimestamp 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | ------- Summary: start ------- 16:25:59 INFO - PROCESS | 24246 | Number of tests: 14 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.12 (1.9%) stddev-sans-first:0.93 16:25:59 INFO - PROCESS | 24246 | Values: 105.0 112.0 110.0 110.0 112.0 111.0 111.0 112.0 112.0 110.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:134.00 stddev:20.99 (15.7%) stddev-sans-first:21.71 16:25:59 INFO - PROCESS | 24246 | Values: 147.0 118.0 121.0 177.0 119.0 120.0 148.0 117.0 153.0 118.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 16:25:59 INFO - PROCESS | 24246 | Values: 160.0 160.0 163.0 161.0 161.0 160.0 161.0 162.0 161.0 162.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:14.35 (18.9%) stddev-sans-first:15.05 16:25:59 INFO - PROCESS | 24246 | Values: 76.0 76.0 77.0 104.0 76.0 76.0 74.0 75.0 114.0 74.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:84.00 stddev:22.56 (26.9%) stddev-sans-first:23.39 16:25:59 INFO - PROCESS | 24246 | Values: 84.0 85.0 118.0 84.0 84.0 84.0 126.0 83.0 84.0 143.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 16:25:59 INFO - PROCESS | 24246 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:25:59 INFO - PROCESS | 24246 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 145.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:25:59 INFO - PROCESS | 24246 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 96.0 95.0 95.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:50.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 16:25:59 INFO - PROCESS | 24246 | Values: 49.0 50.0 50.0 50.0 49.0 50.0 50.0 50.0 49.0 49.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 16:25:59 INFO - PROCESS | 24246 | Values: 60.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 62.0 60.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:2.45 (3.2%) stddev-sans-first:2.13 16:25:59 INFO - PROCESS | 24246 | Values: 81.0 77.0 75.0 75.0 76.0 76.0 76.0 76.0 76.0 82.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:127.50 stddev:16.94 (13.3%) stddev-sans-first:17.82 16:25:59 INFO - PROCESS | 24246 | Values: 124.0 122.0 122.0 120.0 119.0 131.0 131.0 122.0 176.0 134.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:4.06 (2.5%) stddev-sans-first:4.28 16:25:59 INFO - PROCESS | 24246 | Values: 160.0 158.0 161.0 158.0 171.0 165.0 162.0 158.0 159.0 162.0 16:25:59 INFO - PROCESS | 24246 | 16:25:59 INFO - PROCESS | 24246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:1.41 (2.2%) stddev-sans-first:1.50 16:25:59 INFO - PROCESS | 24246 | Values: 63.0 63.0 64.0 63.0 65.0 64.0 62.0 64.0 62.0 60.0 16:25:59 INFO - PROCESS | 24246 | -------- Summary: end -------- 16:25:59 INFO - PROCESS | 24246 | 16:26:00 INFO - TEST-INFO | 24246: exit 0 16:26:00 INFO - TEST-OK | kraken | took 61271ms 16:26:00 INFO - SUITE-END | took 1175s 16:26:00 INFO - Completed test suite (00:19:35) 16:26:00 INFO - javascript benchmark 16:26:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2974.5835583018365, 2976.0625402998057, 2995.341024974506, 3007.2632205109753, 3031.3179534604715, 5094.923576146356, 5143.871403214922, 5161.096808058589, 5170.9482905170935, 5222.34720659917, 5186.611004174683, 5200.583953283738, 5243.580513558915, 5246.921296180561, 5254.7635356408955, 4741.7154970701695, 4760.404949381327, 4768.308595253686, 4772.236442169254, 4866.0, 4780.713157210561, 4813.205821039524, 4814.9759251203695, 4823.951760482403, 4835.323054772335, 4536.795844187003, 4588.7476188809605, 4745.786439610191, 4808.567228949411, 4815.301781241717, 4719.268513380397, 4724.149653062447, 4730.787114579852, 4797.928031079537, 4847.878803029917, 4773.37946067009, 4778.474367819572, 4785.856424307276, 4796.544328288807, 4807.278908163768, 5057.367829021372, 5112.46319136489, 5245.86885327866, 5264.894702105975, 5289.418164001957, 5507.834764957058, 5545.944540554583, 5546.362168350651, 5549.861253468655, 5551.2228288039705, 5569.888602227933, 5594.440555944414, 5610.635308704962, 5610.971945140289, 5615.0, 5008.373953255843, 5095.414027386824, 5147.922781158286, 5179.404368497596, 5211.270422140903, 5707.3721890592005, 5741.138829175574, 5742.167385729046, 5742.7702891883855, 5748.31020277561, 5517.144842549411, 5526.668399896019, 5527.50252477279, 5528.612997090165, 5530.723463826793, 5353.848922481685, 5426.864328391822, 5500.669959802424, 5520.834374968757, 5612.0, 5504.394516603171, 5508.614396992252, 5511.862203444946, 5512.0905050667, 5546.722663866791, 5513.889722205534, 5517.5585953123655, 5522.723863806794, 5523.889522209533, 5573.832785016456, 4180.770057646798, 4198.286291330481, 4225.471816022997, 4249.426327445817, 4325.589069038437, 3764.3036038333, 3784.6404591563755, 3811.951713278815, 3830.674392676598, 3855.9807200963814, 5189.0, 5217.869553261123, 5225.555827754683, 5228.503292187236, 5229.47705229474, 5397.703126328011, 5491.36849262332, 5506.504414602705, 5511.421300763443, 5533.170024496278, 5342.065138600729, 5382.515573598395, 5389.541888939484, 5427.402985671573, 5444.618876678674, 4848.200046992278, 4862.440819305825, 4863.878403039882, 4865.391826021747, 4907.141250281186, 5621.831345059655, 5834.941650583524, 5911.4975227105315, 5920.052791553331, 5924.052151655715, 5590.5527557796095, 5649.971750141223, 5650.3219613646625, 5695.117256825199, 5706.172604972338, 5820.30156381237, 5846.327672317738, 5852.7658893643775, 5867.178594996619, 5939.049752039653, 5267.130923397596, 5376.784928602812, 5492.368377636463, 5538.556915446674, 5541.418151094077, 5492.835214943558, 5555.638883472561, 5560.27716396882, 5610.0, 5612.579056570855, 5394.433584473573, 5435.728213589226, 5436.7281635918835, 5440.972795135999, 5441.700706461183, 5351.063563876384, 5419.864503387289, 5425.213344065168, 5444.972775136099, 5477.643953143033, 5398.217258497574, 5441.129419292894, 5444.183372494158, 5486.725663716878, 5493.725313734377, 5503.174523821459, 5541.058020136506, 5544.334679838284, 5579.497845193952, 5582.804601838916, 5266.183741520071, 5318.388385335581, 5414.648047876875, 5421.430749771217, 5421.593380496557], "value": 5144.613259827466, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.2779238808452, 586.9911951320731, 596.0820336681513, 596.201090538678, 610.9949133675104, 32927.34145317092, 33484.0, 35782.82108589453, 35807.820960895195, 35863.82068089662, 45875.77062114685, 46664.0, 46745.99999999991, 50469.24296135561, 50546.24180637284, 8945.10548945105, 9041.593128309209, 9074.455532668027, 9079.273658107368, 9082.772930676752, 8959.955200223989, 8967.641294348217, 8985.685501007467, 9013.32400069994, 9070.954645226764, 9016.008239093695, 9032.367734258605, 9055.501947392891, 9061.818763624757, 9064.549672052473, 8961.820763584725, 9015.639374425014, 9018.36871419001, 9031.096890310917, 9032.27741780656, 8900.51047192404, 8939.553022348922, 8945.105489451067, 8963.238124759404, 8968.820623587557, 44881.32678009832, 45067.54932450666, 45256.77371613154, 45356.0, 45381.0, 3723.925521489582, 3803.0, 3889.6888248940018, 3920.333543297618, 4097.0, 33260.50109248363, 33991.320173596636, 34125.48811767826, 34131.658683413094, 35834.28331433383, 4298.570142985708, 4375.124975005012, 4383.912321753579, 4576.519465456113, 4627.838025669085, 372760.0, 373416.0, 374618.0, 374994.0, 375676.0, 60971.0, 61631.69184154051, 61636.69181654063, 61661.383386165566, 61723.38276617266, 55063.0, 65864.6706766463, 66098.33901660921, 66129.66935165293, 66135.0, 15685.764713529306, 16158.59603509898, 16277.430289939795, 16564.585885352964, 16583.50249492493, 11999.280043197436, 12040.0, 12050.0, 12051.156419050581, 12066.457009434596, 16266.67466650684, 18759.531011724543, 18772.249110035445, 18789.718154227696, 18876.24495020211, 6855.5543889647015, 6889.931100688929, 6934.549254298556, 7031.156261248683, 7174.31843974832, 911.3256190419042, 956.818204541135, 970.3256236915277, 1008.1078245752561, 1058.3914249306679, 33974.83012584971, 34010.31979360448, 34125.317493649985, 34306.0, 34345.0, 1044.6343779677052, 1063.2025980514613, 1083.4980655376921, 1097.3306283167262, 1109.3011402816173, 17321.480355589352, 17582.912085439748, 17607.647847043245, 17701.38045168413, 17837.10814459272, 556124.0, 562143.0, 563404.0, 563875.0, 565746.0, 62115.0, 62317.37682623207, 62323.0, 62389.376106239266, 62415.0, 1304.1001708820884, 1323.3780123341821, 1325.8607846176205, 1333.7732585460494, 1348.0698318160437, 31520.369592608477, 32421.837890810395, 32985.67014329826, 33011.33977320488, 33260.0, 54643.18035229395, 55062.449375507334, 55129.72435137798, 55130.44869551253, 55218.44781552133, 451791.0, 452506.0, 452959.0, 455338.0, 456792.0, 33064.33871322512, 38037.80981095077, 38052.0, 41325.586744132175, 44851.32723009092, 44520.33219501645, 49724.25413618871, 50043.49956500534, 51068.0, 51796.89218646893, 41315.586844131176, 43097.0, 43486.0, 43982.78008609937, 44331.77834110809, 42329.57670423256, 42485.36271955985, 42627.3605895918, 43423.565764341954, 44134.55865441304, 41862.37206441845, 42715.5728442724, 42960.35559466548, 43583.56416435795, 46665.30002049904, 33390.33219335648, 38763.80618096892, 39018.414723778595, 39092.6090739089, 39933.80033099816, 29477.705222948352, 29671.70328296776, 29965.55051674183, 30031.849840750656, 30061.549076764302], "value": 20725.310251736926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.2434886737849, 369.18226129123985, 369.2356821379745, 375.6750410894577, 391.9784411857348, 14600.488982885588, 18700.345487907907, 19876.40370788875, 20407.795922040776, 20433.795662043376, 18654.440366788986, 18921.337753178643, 20047.799522004774, 20232.39302820918, 20236.29172978946, 5104.591632669396, 5328.893422131555, 5334.973325133369, 5335.493128152839, 5336.252924590561, 5211.062008838408, 5276.577873770089, 5869.2369991901, 5899.0, 5900.0, 5870.677112758796, 5871.618344807595, 5876.147958546008, 5876.177335173079, 5878.588498805086, 5256.3955145158225, 5274.235235890775, 5280.2079688046715, 5283.762230699608, 5582.385937546866, 5147.716875571842, 5149.6910185389, 5150.845474635767, 5151.304573882516, 5157.871053223662, 13498.595042148652, 14606.926965365212, 21590.784092159036, 24433.877830610734, 24613.87693061541, 2122.607317646225, 2346.6597343385283, 2379.654950032236, 2398.2085911649115, 2870.4833130036586, 9918.156956658693, 10304.227182961307, 10319.380837149794, 13074.803877941744, 14485.348159332856, 1945.6400565895212, 1977.713231581427, 2033.7254470646421, 2064.1227478321653, 2115.6826476028564, 83413.58293208556, 87434.8193439686, 87458.56270718605, 88094.55952720196, 88220.55889720574, 10782.892171078189, 11355.375454349925, 11593.88406115945, 11625.24435911663, 11674.416279186007, 16326.75509867353, 16356.509304720877, 16358.182090895407, 16368.0, 16380.180990950405, 8086.312663423557, 8088.352931765445, 8242.29940455056, 8285.50286982783, 8472.534010629475, 7488.588127653032, 7569.962150189324, 7616.581088040211, 7765.990421245202, 7793.2596403341595, 4486.214912390384, 4726.243800991825, 4743.644226683013, 4979.502049794992, 5119.74401279942, 1892.224188082907, 2007.6787713965696, 2043.3461292386294, 2089.5298557824367, 2125.1818050050842, 911.4303560274828, 940.8870935487786, 1024.3853687787268, 1032.1175395037135, 1057.0656493403299, 20149.294774682814, 21021.0, 21175.258865939617, 21187.470313241985, 21203.575928481343, 992.6476100984047, 1012.5899010900597, 1028.1055481730941, 1087.4494774561065, 1111.8443417921496, 10852.94573527143, 11559.76880462386, 11661.416929153509, 11817.290962542274, 11860.94069529664, 367851.0, 368093.0311620392, 372081.0, 453594.0, 496656.0, 74176.62911685408, 75482.0, 91984.54007729919, 96945.5152724246, 97390.0, 984.060222487537, 985.1576901749045, 1007.561710655867, 1026.343140390151, 1027.3117011602244, 18210.72683909716, 18681.53296167607, 19134.904325478285, 19356.0, 19462.513437164183, 40538.18923621452, 42064.53285730689, 44740.77629611831, 44901.10197796091, 45409.31886021778, 60278.397216027275, 60635.69682151561, 61049.694751527735, 62071.0, 62645.0, 8156.8368632625825, 8202.220789025034, 8285.295749861329, 8382.119877412784, 8601.22588966996, 12347.62957111288, 13102.737945241233, 13449.46202151903, 13480.595582132551, 13573.59279221625, 11298.209125361145, 11626.941865290619, 11677.357745323749, 11907.821382679094, 11999.82000270014, 10955.123590112613, 11116.11071114325, 11222.326660400402, 11343.376114313793, 11813.881861181279, 10814.837777433502, 10833.566657333618, 10869.891301086887, 10968.616098436516, 11573.537058517564, 8037.397195210499, 8195.95902020486, 8268.710595129141, 8394.538300393293, 8859.06979767115, 9406.467008472064, 11207.775844483227, 11327.207095503565, 11543.595974140864, 11833.704157396134], "value": 9206.085002532907, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.4968185975838, 1505.6687528743676, 1614.6367067409835, 1754.175537497376, 1778.866585006124, 8160.591970401486, 8726.781830454234, 8735.38852280339, 8736.475811451317, 8742.344324175681, 7402.814929626762, 7584.582847943361, 7616.162222155558, 7802.258785415391, 8578.571071446433, 2312.90748370065, 2395.185636883459, 2399.172285561487, 2409.915652952147, 2419.0565679385054, 2370.7747763962398, 2395.9760402395927, 2414.5050264695697, 2418.733939266688, 2422.685050943375, 2331.090874558915, 2334.6848175496343, 2337.4390146364835, 2339.8479098858606, 2341.0869760793303, 2300.9654855177187, 2347.213683416049, 2348.1194552042984, 2350.6239001759723, 2355.1050600771596, 2278.487340348425, 2284.9543009139725, 2291.2782473520956, 2291.5989701802287, 2299.229758031045, 8672.826543469095, 8755.430896991675, 8760.912390876138, 8763.693270735494, 8764.517951512664, 5136.280920671072, 5273.894522109536, 5274.709890955995, 5275.657082289639, 5279.498447647467, 3209.0854106579745, 3301.735861131104, 3316.303576248991, 3322.3355328934067, 3335.299587086715, 1012.817692815293, 1053.083817079146, 1061.930974486656, 1066.62668066177, 1069.9304545204614, 12109.33398663082, 12123.878761212363, 12125.09061820367, 12135.696607584881, 12145.635630930998, 4260.467441569804, 4437.889052773707, 4651.767411629473, 4651.790669419885, 4655.86032419028, 10225.0, 10271.794564108675, 10301.381917084998, 10318.071373576415, 10327.535260913277, 5261.76322065508, 5283.286756287929, 5285.55072818807, 5291.603129765206, 5292.497212764782, 4800.975995120002, 4865.829695960695, 4867.9269810952865, 4870.245112007645, 4878.804847806119, 3931.4299426582984, 3988.8205030773684, 4026.134381108076, 4073.5315438724924, 4131.338985762263, 1258.79229927061, 1262.5581046633788, 1293.3080801771007, 1307.9215247085206, 1313.1398933698442, 906.6056265524518, 925.8240934222476, 944.7812322104409, 947.4646824544249, 976.4043933200742, 5471.480209380182, 5541.085720856095, 5762.625429347079, 5778.682172480554, 5791.971040144772, 887.2059506741431, 902.9413088149249, 955.8852937647526, 957.7988622389237, 970.9854352184723, 3882.5340959085092, 3965.6827453803626, 4038.9394159087637, 4099.97950010254, 4101.8974525637095, 10468.790624187473, 10830.296030757976, 10845.51195196218, 10882.67351979426, 10921.290116142425, 10025.097741203326, 10353.223508236912, 10354.637587684394, 10365.170786337076, 10815.621453249098, 7764.340031097307, 7972.84054318922, 7976.840463190703, 8119.431639785158, 8126.9593652032545, 5545.944540554543, 5584.441555844545, 5738.512226460798, 5756.802042607603, 5896.616719913192, 9699.709008729467, 10075.0, 10117.747056323651, 10184.796304074025, 10276.434796086287, 10148.949255253972, 10205.795884082128, 10208.59165633396, 10214.131798797185, 10237.232207584311, 7518.699252029857, 8136.633851476579, 8285.95857020711, 8365.456245344034, 8543.957280213559, 8546.658133674584, 8554.401191916506, 8620.482771033758, 8629.827403452022, 8643.265322447662, 7356.411487081128, 7468.626568671436, 7622.69509219625, 7637.198094200251, 7843.137254902071, 7263.0921134858145, 7375.815604609713, 7505.66224519887, 7534.886976695464, 7568.243175682388, 6666.266710661726, 6768.7292508299115, 6778.118844550374, 6780.593164410151, 6785.287544807724, 4886.53577910098, 4933.136701077369, 5066.670666406671, 5098.260752190838, 5285.762140703754, 5025.773840177128, 5095.92356114666, 5164.0, 5266.578673706018, 5315.388730295911], "value": 4594.768791116338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.5955119018491, 316.8970084722463, 318.77048525061946, 323.3452259175171, 332.5942350332594, 5066.594672426207, 5087.847364579059, 5099.133147364948, 5110.897782044357, 5140.1518749406305, 5048.6465947383695, 5049.3940727112795, 5068.67053641513, 5102.413222479416, 5109.437961824206, 4073.287174744423, 4076.388541718736, 4078.3678529827926, 4083.5099788025477, 4093.546790889236, 3949.2299001694537, 4054.6350828425434, 4071.2875246831686, 4087.6934229932726, 4088.5911408859174, 4034.314166591672, 4036.132231570212, 4045.2111838191563, 4055.918881622366, 4064.1871625674985, 3841.5414134953653, 4030.2342554914617, 4056.675465962716, 4058.1883623275166, 4075.735077219986, 3479.6868281854754, 3599.6400359964055, 3617.113807117273, 3622.855085796565, 3631.763935344194, 4945.0, 4954.2568614707725, 4960.718069687948, 4964.60283177345, 4974.403071631391, 4314.80583373749, 4586.793594288265, 4600.4479462464715, 4605.34207685233, 4616.238320677085, 5039.949600503985, 5101.63292227132, 5211.452797456251, 5225.921611175835, 5275.683458992473, 3862.2854771867296, 3864.401017842239, 3871.457995880579, 3871.9419208711893, 3879.1659793144327, 5325.520703136697, 5456.563474921997, 5469.343678758574, 5469.507744302992, 5486.1222204447495, 3946.743461674982, 3969.166475040274, 3975.3043217436834, 3977.8607748728655, 3996.140829721624, 4011.2378648056774, 4020.336644453691, 4029.234445455354, 4031.536373317106, 4037.6769858411258, 4535.206338890747, 4537.410136682276, 4539.296409056601, 4567.634589232854, 4572.833927348572, 5176.663516871391, 5212.83667278083, 5305.620538659976, 5338.519533242027, 5345.198220266913, 1400.9439622414989, 1415.773476243796, 1417.9082106777723, 1418.687713864671, 1421.4243231491262, 891.4027601507006, 927.2165020557618, 932.6662872092837, 938.9812203755887, 940.4827344960381, 4503.774811259424, 4605.355250264965, 4608.340997240991, 4660.254359302563, 4670.299455081765, 4821.035063435962, 4823.252395878644, 4823.662343635982, 4824.517548245148, 4860.902781944412, 4358.694891357574, 4564.543545645475, 4603.654725895572, 4627.190241707688, 4664.976675116603, 2535.404180017694, 2543.5421624107466, 2572.5755250383477, 2736.6031925370708, 2804.144735855584, 5648.74580643872, 5665.858353541112, 5670.06443936754, 5671.432856714296, 5677.205191273225, 5465.234867118606, 5466.590005749585, 5481.835544933659, 5505.862353441116, 5516.503514683617, 5429.4299098594865, 5688.715564221855, 5703.344115426696, 5713.171590119409, 5723.198752174782, 5411.729413529387, 5460.453954604666, 5471.124620060771, 5484.177373394023, 5493.340799103973, 5160.793568257228, 5365.812196573102, 5373.623846330719, 5403.756830942539, 5441.238226648352, 5671.716414179357, 5751.9424805751405, 5785.768569257182, 5786.0, 5799.4780469757925, 3944.526656801202, 3960.168364643457, 3974.1058261890844, 3979.164375481181, 3988.680905527493, 5256.159014557652, 5440.700761458158, 5492.670439773627, 5499.807506737245, 5504.9449505504435, 5331.600129990189, 5344.599155063308, 5349.839504814861, 5351.60858176869, 5359.785608575613, 5263.73681315925, 5331.440198779227, 5333.7866485340155, 5348.705821179872, 5348.786048558014, 5028.446870844277, 5235.842924712265, 5277.102892508359, 5299.258103865539, 5299.364076310867, 5363.674521796511, 5370.758315875717, 5374.6506477078865, 5378.300820893259, 5396.406395296593, 5237.6333656643665, 5247.291615631993, 5280.577553795611, 5288.22844347148, 5288.3918349390315], "value": 4046.1920225790564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.4234358451733, 685.8593988232412, 719.2591630620461, 724.0334153904537, 756.1304499825201, 14734.18961957092, 15591.84408155918, 15635.374585016585, 15735.527934161964, 15799.28903199356, 15199.32807391186, 15566.221688915566, 15571.844281557182, 15581.766273505906, 15602.609934751608, 658.2134349452406, 784.2432053068787, 810.9594520273993, 811.419834818105, 826.4338927834423, 815.2744057788573, 826.0335407573153, 826.1366871619142, 826.4958375391006, 829.2329595124515, 876.045110829196, 880.1682410122437, 881.1408876345575, 881.8853549038616, 882.0429833630518, 691.9100516932791, 849.4351256414539, 870.525563567857, 876.0363600039937, 876.583622779178, 637.3912913167914, 637.611057255074, 637.6492928889139, 637.7544645311542, 637.7831537277348, 13656.24890631015, 13674.31628418585, 13680.726385472235, 13689.520866769715, 13692.794608080887, 14202.573922782332, 14716.55850324492, 14941.252937353089, 14994.775078373834, 15070.924645376703, 13236.735265294736, 13451.86548134516, 13465.192088474723, 13477.730445391135, 13495.392707328194, 4423.623991960687, 4443.133588950156, 4452.30989196675, 4534.13851368239, 4604.079184163181, 84733.0, 85063.5746821262, 85571.14428855757, 86146.56926715389, 88105.55947220288, 11439.84023964054, 11477.54089836414, 11525.76948461026, 11573.826392603949, 11732.882671173178, 21996.780032199793, 22015.449613759785, 22053.558928821334, 22069.889650551646, 22091.0, 8431.704890328809, 8535.231829135408, 8611.655533778703, 8633.827323453495, 8984.101589840964, 4680.672352935262, 4824.107540105092, 4861.319415281863, 4894.458245652608, 5006.07387633289, 3389.9661003390142, 3501.1072176594807, 3522.577290725078, 3528.3119791640897, 3530.064532898784, 604.3050491934223, 618.1006635345561, 627.9246490421178, 629.0407129128025, 636.4208570201095, 596.9910451343234, 676.8578598494273, 701.4809041309394, 717.7093277222733, 720.4704542161508, 9430.3398762086, 9775.364601301035, 9851.211903047739, 10162.695119146438, 10206.489675516343, 664.9035889795953, 669.8593295408019, 686.0, 689.4941556925468, 712.5190496415003, 4543.454785425704, 4593.753247845889, 4732.313814496879, 4807.759612019385, 4908.509149085135, 74233.62883185658, 75032.24967750361, 75231.62384188044, 103448.0, 126829.0, 107074.0, 108006.0, 108369.0, 108766.45616771866, 115314.0, 79171.0, 80511.0, 80594.99999999882, 95276.0, 95402.52298738463, 9517.857232141661, 10395.32430392022, 10485.37087774736, 10495.107915826935, 10572.101371383518, 46602.766986164854, 49104.263436047775, 49245.0, 50927.236091459396, 51710.60459860954, 69180.6540967292, 70155.0, 74951.62524187344, 75308.62345688237, 77592.61203693945, 13344.799828002782, 13364.665883352995, 13523.932380338036, 13570.660733481347, 13977.371018304404, 14547.781783273047, 14636.926815365856, 14698.338574763948, 14933.850661493247, 15256.389744410544, 13491.865081349453, 13630.182189068688, 13635.86364136346, 14303.499377521737, 14767.261636917896, 14244.643883902985, 14723.411063557338, 14745.557633271019, 14943.327550260481, 15073.246337682853, 13935.651608709457, 14176.858231417966, 14295.714085718435, 14799.408023678932, 14871.0, 11300.660980170607, 11308.547658093585, 11777.646670599896, 11988.580399685969, 12035.0, 11120.777584448428, 11447.797981212187, 11803.586874459354, 12288.631341059783, 12369.072319575887], "value": 7674.195730753316, "unit": "score"}], "name": "dromaeo_css", "value": 7206.4303655557915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 110.0, 110.0, 112.0, 111.0, 111.0, 112.0, 112.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 121.0, 177.0, 119.0, 120.0, 148.0, 117.0, 153.0, 118.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 163.0, 161.0, 161.0, 160.0, 161.0, 162.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 104.0, 76.0, 76.0, 74.0, 75.0, 114.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 118.0, 84.0, 84.0, 84.0, 126.0, 83.0, 84.0, 143.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 50.0, 49.0, 50.0, 50.0, 50.0, 49.0, 49.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 75.0, 75.0, 76.0, 76.0, 76.0, 76.0, 76.0, 82.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 122.0, 120.0, 119.0, 131.0, 131.0, 122.0, 176.0, 134.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 161.0, 158.0, 171.0, 165.0, 162.0, 158.0, 159.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 64.0, 62.0, 64.0, 62.0, 60.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1484.8, "alertThreshold": 2.0}]} 16:26:00 INFO - Return code: 0 16:26:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:26:00 INFO - # TBPL SUCCESS # 16:26:00 INFO - Running post-action listener: _resource_record_post_action 16:26:00 INFO - [mozharness: 2016-08-01 23:26:00.545428Z] Finished run-tests step (success) 16:26:00 INFO - Running post-run listener: _resource_record_post_run 16:26:00 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549367808; Read time: 284; Write time: 764428 16:26:00 INFO - TinderboxPrint: CPU usage
13.1% 16:26:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 284 16:26:00 INFO - TinderboxPrint: I/O write bytes / time
549,367,808 / 764,428 16:26:00 INFO - TinderboxPrint: CPU idle
8,278.0 (86.9%) 16:26:00 INFO - TinderboxPrint: CPU user
1,193.7 (12.5%) 16:26:00 INFO - TinderboxPrint: Swap in / out
0 / 0 16:26:00 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 258719744; Read time: 0; Write time: 487276 16:26:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290275328; Read time: 284; Write time: 277116 16:26:01 INFO - Running post-run listener: _upload_blobber_files 16:26:01 INFO - Blob upload gear active. 16:26:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:26:01 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 16:26:01 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:26:01 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:26:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:02 INFO - (blobuploader) - INFO - Done attempting. 16:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:07 INFO - (blobuploader) - INFO - Done attempting. 16:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:08 INFO - (blobuploader) - INFO - Done attempting. 16:26:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:26:08 INFO - Return code: 0 16:26:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:26:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:26:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b09306bf455460cac4702334b7289a18a532e8b7730b23ce9c3d1340aabb11f4b5e89fa3714373f715eab3ff8da1f155bbc2b4be81d001749f6df5058365d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4dedb46ab120dd15dd7356da5368f7b344c7a191f92cbf76b8c2f3d1e016d7fba3bb674f5ee280c5f764e0feea5a4d174d3d782c20993ac5b6b3e4bd341579e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f624fd20aa53b5db21bb15dc4bf8448816b257dd1b9654fd155c310885c5b506429c8b474b56b010ce9cd961fcfec012ffb10b1a085de1af32929f6b9921c5fe"} 16:26:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:26:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:26:08 INFO - Contents: 16:26:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b09306bf455460cac4702334b7289a18a532e8b7730b23ce9c3d1340aabb11f4b5e89fa3714373f715eab3ff8da1f155bbc2b4be81d001749f6df5058365d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4dedb46ab120dd15dd7356da5368f7b344c7a191f92cbf76b8c2f3d1e016d7fba3bb674f5ee280c5f764e0feea5a4d174d3d782c20993ac5b6b3e4bd341579e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f624fd20aa53b5db21bb15dc4bf8448816b257dd1b9654fd155c310885c5b506429c8b474b56b010ce9cd961fcfec012ffb10b1a085de1af32929f6b9921c5fe"} 16:26:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:26:08 INFO - Copying logs to upload dir... 16:26:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:26:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.854041 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-01 16:26:05.357028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 16:26:05.360266) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761 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-Inbound/sha512/0b09306bf455460cac4702334b7289a18a532e8b7730b23ce9c3d1340aabb11f4b5e89fa3714373f715eab3ff8da1f155bbc2b4be81d001749f6df5058365d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4dedb46ab120dd15dd7356da5368f7b344c7a191f92cbf76b8c2f3d1e016d7fba3bb674f5ee280c5f764e0feea5a4d174d3d782c20993ac5b6b3e4bd341579e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f624fd20aa53b5db21bb15dc4bf8448816b257dd1b9654fd155c310885c5b506429c8b474b56b010ce9cd961fcfec012ffb10b1a085de1af32929f6b9921c5fe"} build_url:https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/QKUTRUU2REqLKnBgXjn00A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b09306bf455460cac4702334b7289a18a532e8b7730b23ce9c3d1340aabb11f4b5e89fa3714373f715eab3ff8da1f155bbc2b4be81d001749f6df5058365d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4dedb46ab120dd15dd7356da5368f7b344c7a191f92cbf76b8c2f3d1e016d7fba3bb674f5ee280c5f764e0feea5a4d174d3d782c20993ac5b6b3e4bd341579e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f624fd20aa53b5db21bb15dc4bf8448816b257dd1b9654fd155c310885c5b506429c8b474b56b010ce9cd961fcfec012ffb10b1a085de1af32929f6b9921c5fe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 16:26:05.384515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:26:05.384792) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470092732.764879-731344761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:26:05.470368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 16:26:05.470653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 16:26:05.470919) ========= ========= Total master_lag: 0.14 =========