builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1465038752.92 results: success (0) buildid: 20160604011925 builduid: 03e7a287c64e4dec9f34514b4444eea2 revision: 240b7e66dfef9a2dccd39bb32846ab41ece57fb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.923699) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.924127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.924469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.986572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.986872) ========= 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=41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 04:12: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.5M=0s 2016-06-04 04:12:33 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.376922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.379046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.379391) ========= 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=41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023052 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.429239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.429616) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 240b7e66dfef9a2dccd39bb32846ab41ece57fb8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 240b7e66dfef9a2dccd39bb32846ab41ece57fb8 --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=41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 04:12:33,966 truncating revision to first 12 chars 2016-06-04 04:12:33,966 Setting DEBUG logging. 2016-06-04 04:12:33,966 attempt 1/10 2016-06-04 04:12:33,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/240b7e66dfef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 04:12:34,291 unpacking tar archive at: mozilla-aurora-240b7e66dfef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:34.089977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:34.090287) ========= script_repo_revision: 240b7e66dfef9a2dccd39bb32846ab41ece57fb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:34.090690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:34.090965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:34.101043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-04 04:12:34.101311) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:12:34 INFO - MultiFileLogger online at 20160604 04:12:34 in /builds/slave/test 04:12:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:12:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:34 INFO - {'append_to_log': False, 04:12:34 INFO - 'base_work_dir': '/builds/slave/test', 04:12:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:12:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:34 INFO - 'branch': 'Mozilla-Aurora', 04:12:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:34 INFO - 'config_files': ('talos/linux_config.py',), 04:12:34 INFO - 'default_actions': ('clobber', 04:12:34 INFO - 'read-buildbot-config', 04:12:34 INFO - 'download-and-extract', 04:12:34 INFO - 'populate-webroot', 04:12:34 INFO - 'create-virtualenv', 04:12:34 INFO - 'install', 04:12:34 INFO - 'run-tests'), 04:12:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:34 INFO - 'download_minidump_stackwalk': True, 04:12:34 INFO - 'download_symbols': 'ondemand', 04:12:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:34 INFO - 'installer_path': 'installer.exe', 04:12:34 INFO - 'log_level': 'info', 04:12:34 INFO - 'log_name': 'talos', 04:12:34 INFO - 'log_to_console': True, 04:12:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:12:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:12:34 INFO - 'opt_config_files': (), 04:12:34 INFO - 'pip_index': False, 04:12:34 INFO - 'sps_profile': False, 04:12:34 INFO - 'sps_profile_interval': 0, 04:12:34 INFO - 'suite': 'dromaeojs', 04:12:34 INFO - 'system_bits': '32', 04:12:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:34 INFO - 'title': 'talos-linux64-ix-026', 04:12:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:34 INFO - 'use_talos_json': True, 04:12:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:34 INFO - 'work_dir': 'build'} 04:12:34 INFO - ##### 04:12:34 INFO - ##### Running clobber step. 04:12:34 INFO - ##### 04:12:34 INFO - Running pre-action listener: _resource_record_pre_action 04:12:34 INFO - Running main action method: clobber 04:12:34 INFO - rmtree: /builds/slave/test/build 04:12:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:35 INFO - Running post-action listener: _resource_record_post_action 04:12:35 INFO - ##### 04:12:35 INFO - ##### Running read-buildbot-config step. 04:12:35 INFO - ##### 04:12:35 INFO - Running pre-action listener: _resource_record_pre_action 04:12:35 INFO - Running main action method: read_buildbot_config 04:12:35 INFO - Using buildbot properties: 04:12:35 INFO - { 04:12:35 INFO - "project": "", 04:12:35 INFO - "product": "firefox", 04:12:35 INFO - "script_repo_revision": "production", 04:12:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:12:35 INFO - "repository": "", 04:12:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:12:35 INFO - "buildid": "20160604011925", 04:12:35 INFO - "pgo_build": "True", 04:12:35 INFO - "basedir": "/builds/slave/test", 04:12:35 INFO - "buildnumber": 359, 04:12:35 INFO - "slavename": "talos-linux64-ix-026", 04:12:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:12:35 INFO - "platform": "ubuntu64_hw", 04:12:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:12:35 INFO - "branch": "mozilla-aurora", 04:12:35 INFO - "repo_path": "releases/mozilla-aurora", 04:12:35 INFO - "revision": "240b7e66dfef9a2dccd39bb32846ab41ece57fb8", 04:12:35 INFO - "stage_platform": "linux64-pgo", 04:12:35 INFO - "builduid": "03e7a287c64e4dec9f34514b4444eea2", 04:12:35 INFO - "slavebuilddir": "test" 04:12:35 INFO - } 04:12:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:12:35 INFO - Running post-action listener: _resource_record_post_action 04:12:35 INFO - ##### 04:12:35 INFO - ##### Running download-and-extract step. 04:12:35 INFO - ##### 04:12:35 INFO - Running pre-action listener: _resource_record_pre_action 04:12:35 INFO - Running main action method: download_and_extract 04:12:35 INFO - mkdir: /builds/slave/test/build/tests 04:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:35 INFO - https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:12:36 INFO - Downloaded 1361 bytes. 04:12:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:12:36 INFO - Using the following test package requirements: 04:12:36 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:12:36 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:12:36 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:12:36 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'jsshell-linux-x86_64.zip'], 04:12:36 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:12:36 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:12:36 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:12:36 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:12:36 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:12:36 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:12:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:12: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')]} 04:12:36 INFO - https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:38 INFO - Downloaded 24177256 bytes. 04:12:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:39 INFO - Return code: 0 04:12:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:12: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')]} 04:12:39 INFO - https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:12:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:12:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:12:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:41 INFO - Downloaded 24177256 bytes. 04:12:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:42 INFO - Return code: 0 04:12: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')]} 04:12:42 INFO - https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:12:43 INFO - Downloaded 10840145 bytes. 04:12:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:12:43 INFO - Return code: 0 04:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:43 INFO - https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:12:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:12:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:12:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:12:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:12:45 INFO - Downloaded 62806103 bytes. 04:12:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:12:45 INFO - mkdir: /builds/slave/test/properties 04:12:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:45 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:45 INFO - Contents: 04:12:45 INFO - build_url:https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:12:45 INFO - Running post-action listener: _resource_record_post_action 04:12:45 INFO - Running post-action listener: set_extra_try_arguments 04:12:45 INFO - ##### 04:12:45 INFO - ##### Running populate-webroot step. 04:12:45 INFO - ##### 04:12:45 INFO - Running pre-action listener: _resource_record_pre_action 04:12:45 INFO - Running main action method: populate_webroot 04:12:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:45 INFO - '--tppagecycles', 04:12:45 INFO - '7'], 04:12:45 INFO - 'tests': ['tsvgm']}}, 04:12:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['damp', 'tps']}, 04:12:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'tests': ['damp', 'tps']}, 04:12:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['dromaeo_dom']}, 04:12:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tsvgx', 04:12:45 INFO - 'tsvgr_opacity', 04:12:45 INFO - 'tart', 04:12:45 INFO - 'tscrollx', 04:12:45 INFO - 'cart']}, 04:12:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:45 INFO - 'tsvgr_opacity', 04:12:45 INFO - 'tart', 04:12:45 INFO - 'tscrollx', 04:12:45 INFO - 'cart']}, 04:12:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tp5o']}, 04:12:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'tests': ['tp5o']}, 04:12:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s', 04:12:45 INFO - '--xperf_path', 04:12:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:45 INFO - 'tests': ['tp5n']}, 04:12:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--xperf_path', 04:12:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:45 INFO - 'tests': ['tp5n']}}, 04:12:45 INFO - 'talos.zip': {'path': '', 04:12:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:45 INFO - Running post-action listener: _resource_record_post_action 04:12:45 INFO - ##### 04:12:45 INFO - ##### Running create-virtualenv step. 04:12:45 INFO - ##### 04:12:45 INFO - Running pre-action listener: _resource_record_pre_action 04:12:45 INFO - Running main action method: create_virtualenv 04:12:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12: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 04:12:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:46 INFO - Using real prefix '/usr' 04:12:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:48 INFO - Installing pip.................done. 04:12:48 INFO - Return code: 0 04:12:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12: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', 'pip>=1.5'] in /builds/slave/test/build 04:12: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 pip>=1.5 04:12:48 INFO - Using env: {'DISPLAY': ':0', 04:12:48 INFO - 'HOME': '/home/cltbld', 04:12:48 INFO - 'LANG': 'en_US.UTF-8', 04:12:48 INFO - 'LANGUAGE': 'en_US:en', 04:12:48 INFO - 'LOGNAME': 'cltbld', 04:12:48 INFO - 'MAIL': '/var/mail/cltbld', 04:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:48 INFO - 'MOZ_NO_REMOTE': '1', 04:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:48 INFO - 'NO_EM_RESTART': '1', 04:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:48 INFO - 'PWD': '/builds/slave/test', 04:12:48 INFO - 'SHELL': '/bin/bash', 04:12:48 INFO - 'SHLVL': '1', 04:12:48 INFO - 'TERM': 'linux', 04:12:48 INFO - 'TMOUT': '86400', 04:12:48 INFO - 'USER': 'cltbld', 04:12:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:48 INFO - '_': '/tools/buildbot/bin/python'} 04:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12: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 04:12:48 INFO - Cleaning up... 04:12:48 INFO - Return code: 0 04:12:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12: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>=0.7.1'] in /builds/slave/test/build 04:12: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>=0.7.1 04:12:48 INFO - Using env: {'DISPLAY': ':0', 04:12:48 INFO - 'HOME': '/home/cltbld', 04:12:48 INFO - 'LANG': 'en_US.UTF-8', 04:12:48 INFO - 'LANGUAGE': 'en_US:en', 04:12:48 INFO - 'LOGNAME': 'cltbld', 04:12:48 INFO - 'MAIL': '/var/mail/cltbld', 04:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:48 INFO - 'MOZ_NO_REMOTE': '1', 04:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:48 INFO - 'NO_EM_RESTART': '1', 04:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:48 INFO - 'PWD': '/builds/slave/test', 04:12:48 INFO - 'SHELL': '/bin/bash', 04:12:48 INFO - 'SHLVL': '1', 04:12:48 INFO - 'TERM': 'linux', 04:12:48 INFO - 'TMOUT': '86400', 04:12:48 INFO - 'USER': 'cltbld', 04:12:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:48 INFO - '_': '/tools/buildbot/bin/python'} 04:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:48 INFO - Downloading/unpacking psutil>=0.7.1 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:50 INFO - Installing collected packages: psutil 04:12:50 INFO - Running setup.py install for psutil 04:12:50 INFO - building 'psutil._psutil_linux' extension 04:12: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 04:12:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:12:51 INFO - building 'psutil._psutil_posix' extension 04:12:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:12:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:51 INFO - Successfully installed psutil 04:12:51 INFO - Cleaning up... 04:12:51 INFO - Return code: 0 04:12:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:12:51 INFO - Using env: {'DISPLAY': ':0', 04:12:51 INFO - 'HOME': '/home/cltbld', 04:12:51 INFO - 'LANG': 'en_US.UTF-8', 04:12:51 INFO - 'LANGUAGE': 'en_US:en', 04:12:51 INFO - 'LOGNAME': 'cltbld', 04:12:51 INFO - 'MAIL': '/var/mail/cltbld', 04:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:51 INFO - 'MOZ_NO_REMOTE': '1', 04:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:51 INFO - 'NO_EM_RESTART': '1', 04:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:51 INFO - 'PWD': '/builds/slave/test', 04:12:51 INFO - 'SHELL': '/bin/bash', 04:12:51 INFO - 'SHLVL': '1', 04:12:51 INFO - 'TERM': 'linux', 04:12:51 INFO - 'TMOUT': '86400', 04:12:51 INFO - 'USER': 'cltbld', 04:12:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:51 INFO - '_': '/tools/buildbot/bin/python'} 04:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:12:53 INFO - Installing collected packages: mozsystemmonitor 04:12:53 INFO - Running setup.py install for mozsystemmonitor 04:12:53 INFO - Successfully installed mozsystemmonitor 04:12:53 INFO - Cleaning up... 04:12:53 INFO - Return code: 0 04:12:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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', '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 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:12: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 blobuploader==1.2.4 04:12:53 INFO - Using env: {'DISPLAY': ':0', 04:12:53 INFO - 'HOME': '/home/cltbld', 04:12:53 INFO - 'LANG': 'en_US.UTF-8', 04:12:53 INFO - 'LANGUAGE': 'en_US:en', 04:12:53 INFO - 'LOGNAME': 'cltbld', 04:12:53 INFO - 'MAIL': '/var/mail/cltbld', 04:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:53 INFO - 'MOZ_NO_REMOTE': '1', 04:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:53 INFO - 'NO_EM_RESTART': '1', 04:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:53 INFO - 'PWD': '/builds/slave/test', 04:12:53 INFO - 'SHELL': '/bin/bash', 04:12:53 INFO - 'SHLVL': '1', 04:12:53 INFO - 'TERM': 'linux', 04:12:53 INFO - 'TMOUT': '86400', 04:12:53 INFO - 'USER': 'cltbld', 04:12:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:53 INFO - '_': '/tools/buildbot/bin/python'} 04:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:56 INFO - Downloading docopt-0.6.1.tar.gz 04:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:56 INFO - Running setup.py install for blobuploader 04:12:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:56 INFO - Running setup.py install for requests 04:12:57 INFO - Running setup.py install for docopt 04:12:57 INFO - Successfully installed blobuploader requests docopt 04:12:57 INFO - Cleaning up... 04:12:57 INFO - Return code: 0 04:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 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 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:57 INFO - Using env: {'DISPLAY': ':0', 04:12:57 INFO - 'HOME': '/home/cltbld', 04:12:57 INFO - 'LANG': 'en_US.UTF-8', 04:12:57 INFO - 'LANGUAGE': 'en_US:en', 04:12:57 INFO - 'LOGNAME': 'cltbld', 04:12:57 INFO - 'MAIL': '/var/mail/cltbld', 04:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:57 INFO - 'MOZ_NO_REMOTE': '1', 04:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:57 INFO - 'NO_EM_RESTART': '1', 04:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:57 INFO - 'PWD': '/builds/slave/test', 04:12:57 INFO - 'SHELL': '/bin/bash', 04:12:57 INFO - 'SHLVL': '1', 04:12:57 INFO - 'TERM': 'linux', 04:12:57 INFO - 'TMOUT': '86400', 04:12:57 INFO - 'USER': 'cltbld', 04:12:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:57 INFO - '_': '/tools/buildbot/bin/python'} 04:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:57 INFO - Running setup.py (path:/tmp/pip-i5hagY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:57 INFO - Running setup.py (path:/tmp/pip-UZQ8LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:57 INFO - Running setup.py (path:/tmp/pip-hFatKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:57 INFO - Running setup.py (path:/tmp/pip-b9FUGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:57 INFO - Running setup.py (path:/tmp/pip-SGIgZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:57 INFO - Running setup.py (path:/tmp/pip-xRL_br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:57 INFO - Running setup.py (path:/tmp/pip-wJbEPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:57 INFO - Running setup.py (path:/tmp/pip-jrrdY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:57 INFO - Running setup.py (path:/tmp/pip-CJRalF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:58 INFO - Running setup.py (path:/tmp/pip-WApFs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:58 INFO - Running setup.py (path:/tmp/pip-mjMmZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:58 INFO - Running setup.py (path:/tmp/pip-qdcTTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:58 INFO - Running setup.py (path:/tmp/pip-NO55WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:58 INFO - Running setup.py (path:/tmp/pip-uAld8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:58 INFO - Running setup.py (path:/tmp/pip-k7Fb29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:58 INFO - Running setup.py (path:/tmp/pip-zuq0cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:58 INFO - Running setup.py (path:/tmp/pip-RfeT2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:58 INFO - Running setup.py install for manifestparser 04:12:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:58 INFO - Running setup.py install for mozcrash 04:12:58 INFO - Running setup.py install for mozdebug 04:12:58 INFO - Running setup.py install for mozdevice 04:12:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for mozfile 04:12:59 INFO - Running setup.py install for mozhttpd 04:12:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for mozinfo 04:12:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for mozInstall 04:12:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for mozleak 04:12:59 INFO - Running setup.py install for mozlog 04:12:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for moznetwork 04:12:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for mozprocess 04:12:59 INFO - Running setup.py install for mozprofile 04:12:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for mozrunner 04:13:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for mozscreenshot 04:13:00 INFO - Running setup.py install for moztest 04:13:00 INFO - Running setup.py install for mozversion 04:13:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:00 INFO - Cleaning up... 04:13:00 INFO - Return code: 0 04:13:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:00 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 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:00 INFO - Using env: {'DISPLAY': ':0', 04:13:00 INFO - 'HOME': '/home/cltbld', 04:13:00 INFO - 'LANG': 'en_US.UTF-8', 04:13:00 INFO - 'LANGUAGE': 'en_US:en', 04:13:00 INFO - 'LOGNAME': 'cltbld', 04:13:00 INFO - 'MAIL': '/var/mail/cltbld', 04:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:00 INFO - 'MOZ_NO_REMOTE': '1', 04:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:00 INFO - 'NO_EM_RESTART': '1', 04:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:00 INFO - 'PWD': '/builds/slave/test', 04:13:00 INFO - 'SHELL': '/bin/bash', 04:13:00 INFO - 'SHLVL': '1', 04:13:00 INFO - 'TERM': 'linux', 04:13:00 INFO - 'TMOUT': '86400', 04:13:00 INFO - 'USER': 'cltbld', 04:13:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:00 INFO - '_': '/tools/buildbot/bin/python'} 04:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:00 INFO - Running setup.py (path:/tmp/pip-WH1IQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:00 INFO - Running setup.py (path:/tmp/pip-V_0m1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:00 INFO - Running setup.py (path:/tmp/pip-4j5q8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:00 INFO - Running setup.py (path:/tmp/pip-IGqu5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:00 INFO - Running setup.py (path:/tmp/pip-kKKx7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:01 INFO - Running setup.py (path:/tmp/pip-xLcC4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:01 INFO - Running setup.py (path:/tmp/pip-aIGy_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:01 INFO - Running setup.py (path:/tmp/pip-SDKv7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:01 INFO - Running setup.py (path:/tmp/pip-efRyaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:01 INFO - Running setup.py (path:/tmp/pip-o9qkPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:01 INFO - Running setup.py (path:/tmp/pip-lyh_bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:01 INFO - Running setup.py (path:/tmp/pip-aWvTOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:01 INFO - Running setup.py (path:/tmp/pip-U8yfy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:01 INFO - Running setup.py (path:/tmp/pip-aAlsmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:01 INFO - Running setup.py (path:/tmp/pip-K234Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:01 INFO - Running setup.py (path:/tmp/pip-AbssxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:01 INFO - Running setup.py (path:/tmp/pip-gxVKPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:03 INFO - Downloading blessings-1.6.tar.gz 04:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:03 INFO - Installing collected packages: blessings 04:13:03 INFO - Running setup.py install for blessings 04:13:03 INFO - Successfully installed blessings 04:13:03 INFO - Cleaning up... 04:13:04 INFO - Return code: 0 04:13:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:04 INFO - Reading from file tmpfile_stdout 04:13:04 INFO - Current package versions: 04:13:04 INFO - argparse == 1.2.1 04:13:04 INFO - blessings == 1.6 04:13:04 INFO - blobuploader == 1.2.4 04:13:04 INFO - docopt == 0.6.1 04:13:04 INFO - manifestparser == 1.1 04:13:04 INFO - mozInstall == 1.12 04:13:04 INFO - mozcrash == 0.17 04:13:04 INFO - mozdebug == 0.1 04:13:04 INFO - mozdevice == 0.48 04:13:04 INFO - mozfile == 1.2 04:13:04 INFO - mozhttpd == 0.7 04:13:04 INFO - mozinfo == 0.9 04:13:04 INFO - mozleak == 0.1 04:13:04 INFO - mozlog == 3.1 04:13:04 INFO - moznetwork == 0.27 04:13:04 INFO - mozprocess == 0.22 04:13:04 INFO - mozprofile == 0.28 04:13:04 INFO - mozrunner == 6.11 04:13:04 INFO - mozscreenshot == 0.1 04:13:04 INFO - mozsystemmonitor == 0.0 04:13:04 INFO - moztest == 0.7 04:13:04 INFO - mozversion == 1.4 04:13:04 INFO - psutil == 3.1.1 04:13:04 INFO - requests == 1.2.3 04:13:04 INFO - wsgiref == 0.1.2 04:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:04 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 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:04 INFO - Using env: {'DISPLAY': ':0', 04:13:04 INFO - 'HOME': '/home/cltbld', 04:13:04 INFO - 'LANG': 'en_US.UTF-8', 04:13:04 INFO - 'LANGUAGE': 'en_US:en', 04:13:04 INFO - 'LOGNAME': 'cltbld', 04:13:04 INFO - 'MAIL': '/var/mail/cltbld', 04:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:04 INFO - 'MOZ_NO_REMOTE': '1', 04:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:04 INFO - 'NO_EM_RESTART': '1', 04:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:04 INFO - 'PWD': '/builds/slave/test', 04:13:04 INFO - 'SHELL': '/bin/bash', 04:13:04 INFO - 'SHLVL': '1', 04:13:04 INFO - 'TERM': 'linux', 04:13:04 INFO - 'TMOUT': '86400', 04:13:04 INFO - 'USER': 'cltbld', 04:13:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:04 INFO - '_': '/tools/buildbot/bin/python'} 04:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:04 INFO - Cleaning up... 04:13:04 INFO - Return code: 0 04:13:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:04 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 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:04 INFO - Using env: {'DISPLAY': ':0', 04:13:04 INFO - 'HOME': '/home/cltbld', 04:13:04 INFO - 'LANG': 'en_US.UTF-8', 04:13:04 INFO - 'LANGUAGE': 'en_US:en', 04:13:04 INFO - 'LOGNAME': 'cltbld', 04:13:04 INFO - 'MAIL': '/var/mail/cltbld', 04:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:04 INFO - 'MOZ_NO_REMOTE': '1', 04:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:04 INFO - 'NO_EM_RESTART': '1', 04:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:04 INFO - 'PWD': '/builds/slave/test', 04:13:04 INFO - 'SHELL': '/bin/bash', 04:13:04 INFO - 'SHLVL': '1', 04:13:04 INFO - 'TERM': 'linux', 04:13:04 INFO - 'TMOUT': '86400', 04:13:04 INFO - 'USER': 'cltbld', 04:13:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:04 INFO - '_': '/tools/buildbot/bin/python'} 04:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:04 INFO - Downloading/unpacking jsonschema 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:06 INFO - warning: no files found matching '*.txt' 04:13:06 INFO - no previously-included directories found matching 'build' 04:13:06 INFO - no previously-included directories found matching 'dist' 04:13:06 INFO - no previously-included directories found matching '.git*' 04:13:06 INFO - Installing collected packages: jsonschema, functools32 04:13:06 INFO - Running setup.py install for functools32 04:13:07 INFO - warning: no files found matching '*.txt' 04:13:07 INFO - no previously-included directories found matching 'build' 04:13:07 INFO - no previously-included directories found matching 'dist' 04:13:07 INFO - no previously-included directories found matching '.git*' 04:13:07 INFO - Successfully installed jsonschema functools32 04:13:07 INFO - Cleaning up... 04:13:07 INFO - Return code: 0 04:13:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4aea87ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, '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': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:13:07 INFO - Using env: {'DISPLAY': ':0', 04:13:07 INFO - 'HOME': '/home/cltbld', 04:13:07 INFO - 'LANG': 'en_US.UTF-8', 04:13:07 INFO - 'LANGUAGE': 'en_US:en', 04:13:07 INFO - 'LOGNAME': 'cltbld', 04:13:07 INFO - 'MAIL': '/var/mail/cltbld', 04:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:07 INFO - 'MOZ_NO_REMOTE': '1', 04:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:07 INFO - 'NO_EM_RESTART': '1', 04:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:07 INFO - 'PWD': '/builds/slave/test', 04:13:07 INFO - 'SHELL': '/bin/bash', 04:13:07 INFO - 'SHLVL': '1', 04:13:07 INFO - 'TERM': 'linux', 04:13:07 INFO - 'TMOUT': '86400', 04:13:07 INFO - 'USER': 'cltbld', 04:13:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:07 INFO - '_': '/tools/buildbot/bin/python'} 04:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:07 INFO - Downloading/unpacking flake8 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:09 INFO - no previously-included directories found matching 'docs/_build' 04:13:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:10 INFO - Running setup.py install for pep8 04:13:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:10 INFO - no previously-included directories found matching 'docs/_build' 04:13:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:10 INFO - Cleaning up... 04:13:10 INFO - Return code: 0 04:13:10 INFO - Running post-action listener: _resource_record_post_action 04:13:10 INFO - Running post-action listener: _start_resource_monitoring 04:13:10 INFO - Starting resource monitoring. 04:13:10 INFO - ##### 04:13:10 INFO - ##### Running install step. 04:13:10 INFO - ##### 04:13:10 INFO - Running pre-action listener: _resource_record_pre_action 04:13:10 INFO - Running main action method: install 04:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:10 INFO - Reading from file tmpfile_stdout 04:13:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:10 INFO - Reading from file tmpfile_stdout 04:13:10 INFO - Output received: 04:13:10 INFO - Usage: mozinstall [options] installer 04:13:10 INFO - Options: 04:13:10 INFO - -h, --help show this help message and exit 04:13:10 INFO - -d DEST, --destination=DEST 04:13:10 INFO - Directory to install application into. [default: 04:13:10 INFO - "/builds/slave/test"] 04:13:10 INFO - --app=APP Application being installed. [default: firefox] 04:13:10 INFO - mkdir: /builds/slave/test/build/application 04:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:13:26 INFO - Reading from file tmpfile_stdout 04:13:26 INFO - Output received: 04:13:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:26 INFO - Running post-action listener: _resource_record_post_action 04:13:26 INFO - ##### 04:13:26 INFO - ##### Running run-tests step. 04:13:26 INFO - ##### 04:13:26 INFO - Running pre-action listener: _resource_record_pre_action 04:13:26 INFO - Running main action method: run_tests 04:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:26 INFO - Python 2.7.3 04:13:26 INFO - Return code: 0 04:13:26 INFO - grabbing minidump binary from tooltool 04:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:26 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565410>, '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 0x2566310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25667a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:13:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:26 INFO - Return code: 0 04:13:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:13:27 INFO - Return code: 0 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:13:27 INFO - mozversion application_buildid: 20160604011925 04:13:27 INFO - mozversion application_changeset: 240b7e66dfef9a2dccd39bb32846ab41ece57fb8 04:13:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:13:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:27 INFO - mozversion application_name: Firefox 04:13:27 INFO - mozversion application_remotingname: firefox-dev 04:13:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:13:27 INFO - mozversion application_vendor: Mozilla 04:13:27 INFO - mozversion application_version: 48.0a2 04:13:27 INFO - mozversion platform_buildid: 20160604011925 04:13:27 INFO - mozversion platform_changeset: 240b7e66dfef9a2dccd39bb32846ab41ece57fb8 04:13:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:13:27 INFO - mozversion platform_version: 48.0a2 04:13:27 INFO - using testdate: 1465038807 04:13:27 INFO - actual date: 1465038807 04:13:27 INFO - starting webserver on 'localhost:55697' 04:13:27 INFO - SUITE-START | Running 2 tests 04:13:27 INFO - TEST-START | dromaeo_css 04:13:27 INFO - operating with platform_type : linux_ 04:13:27 INFO - Initialising browser for dromaeo_css test... 04:13:27 INFO - TEST-INFO | started process 19009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWAXHzc/profile http://localhost:55697/getInfo.html) 04:13:31 INFO - PROCESS | 19009 | __metrics Screen width/height:1600/1200 04:13:31 INFO - PROCESS | 19009 | colorDepth:24 04:13:31 INFO - PROCESS | 19009 | Browser inner width/height: 1024/697 04:13:31 INFO - PROCESS | 19009 | __metrics 04:13:32 ERROR - PROCESS | 19009 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:13:33 INFO - TEST-INFO | 19009: exit 0 04:13:33 INFO - Browser initialized. 04:13:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:33 INFO - TEST-INFO | started process 19100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWAXHzc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:44 INFO - PROCESS | 19100 | RSS: Main: 142794752 04:13:44 INFO - PROCESS | 19100 | 04:14:36 INFO - PROCESS | 19100 | 1465038876033 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:16:43 INFO - PROCESS | 19100 | Cycle 1(1): loaded http://localhost:55697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55697/tests/dromaeo/cssquery-ext.html) 04:16:44 INFO - PROCESS | 19100 | RSS: Main: 245997568 04:16:44 INFO - PROCESS | 19100 | 04:19:46 INFO - PROCESS | 19100 | Cycle 1(1): loaded http://localhost:55697/tests/dromaeo/cssquery-ext.html (next: http://localhost:55697/tests/dromaeo/cssquery-jquery.html) 04:19:47 INFO - PROCESS | 19100 | RSS: Main: 225112064 04:19:47 INFO - PROCESS | 19100 | 04:22:49 INFO - PROCESS | 19100 | Cycle 1(1): loaded http://localhost:55697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55697/tests/dromaeo/cssquery-mootools.html) 04:22:49 INFO - PROCESS | 19100 | RSS: Main: 216576000 04:22:49 INFO - PROCESS | 19100 | 04:25:51 INFO - PROCESS | 19100 | Cycle 1(1): loaded http://localhost:55697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55697/tests/dromaeo/cssquery-prototype.html) 04:25:52 INFO - PROCESS | 19100 | RSS: Main: 215670784 04:25:52 INFO - PROCESS | 19100 | 04:28:54 INFO - PROCESS | 19100 | Cycle 1(1): loaded http://localhost:55697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55697/tests/dromaeo/cssquery-yui.html) 04:28:55 INFO - PROCESS | 19100 | RSS: Main: 212922368 04:28:55 INFO - PROCESS | 19100 | 04:31:57 INFO - PROCESS | 19100 | Cycle 1(1): loaded http://localhost:55697/tests/dromaeo/cssquery-yui.html (next: http://localhost:55697/tests/dromaeo/cssquery-dojo.html) 04:31:58 INFO - PROCESS | 19100 | RSS: Main: 256352256 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | __start_tp_report 04:31:58 INFO - PROCESS | 19100 | _x_x_mozilla_page_load 04:31:58 INFO - PROCESS | 19100 | _x_x_mozilla_page_load_details 04:31:58 INFO - PROCESS | 19100 | |i|pagename|runs| 04:31:58 INFO - PROCESS | 19100 | |0;dojo.html;3276.0499455158006;3377.071305391017;3395.354882572311;3427.5886893572742;3437.0548099272696;5577.8605534861645;5580.776768929243;5584.58115641327;5623.522000629946;5625.268715067045;5560.888782224353;5612.803551875675;5618.831435056944;5622.184783206443;5630.09918413054;4971.304017437562;5034.446210916796;5061.746912654362;5110.591152707793;5171.844844654666;4956.1822299320565;4989.151844186479;5018.222175562775;5035.924461133068;5039.546440820325;5026.045051440233;5057.77240024198;5095.3885533736;5111.718855462948;5124.590032797368;5119.820806271781;5171.120909445403;5174.275601415805;5177.378714554277;5213.1919552469235;4920.138975679241;4978.87552811179;5054.7472626368535;5063.696178229318;5074.82238121664;5434.7826086956475;5443.972780136074;5477.972610136963;5478.808241711561;5502.0371434999115;5904.5571582131515;5906.822795316148;5914.497267732248;5919.378465261172;5923.022701254331;5981.671008094553;6003.3996600339615;6103;6128.111423843562;6137.11011903276;5552.08390615548;5593.636413633101;5600.859978500489;5601.887962240732;5609.214709940612;5980.491658209101;6091.756329746849;6096.786612468542;6100.054491553817;6109.327973922865;5869.853253668693;5911.201987731687;5932.911006334908;5942.643441393444;5942.762289508371;5954.49386802118;5964.314103878023;5965.522758179335;5965.7613695452565;5967.6419414835245;5784.074548072288;5898.8820223595285;5913.053911374245;5915.497182739429;5921.7631294747725;5936.050231962865;5952.404759524013;5957.6127551709;5960.552958528127;6002.579819412686;4532.365468834366;4540.886477838015;4545.6136228420955;4546.954530454719;4570;3975.0658595230097;4041.151358214749;4071.1247081876945;4085.9795701021303;4117.382392641128;5660.377358490645;5688.374278829326;5689.146628005832;5693.146028095736;5714.685692286964;5936.5844390892225;5964.7912323068485;5988.191594134736;5988.951933411636;5989.490893274034;5503.889922201533;5643.1535269709875;5646.350669672958;5698.857528561819;5792.4497172768515;5161.225816127611;5162.664426812245;5163.845084647466;5166.43169251382;5190.24741412493;6190.628562286277;6207.534434917399;6208.255009398811;6211.3478084800445;6213.099100630383;5887.264091988502;5976.64140151601;5977.043673012297;5999.970000149971;6051.909221361771;6191;6196.969015154896;6228.968855155696;6232.407921247474;6232.8130156095385;5899.970500147472;5927.110933360031;5929.644221346733;5932.733027013708;5963.433473820153;5765.91351129725;5919.289685237799;5978.192943952511;5979.312379076462;5981.102834574848;5845.795397161079;5867.882642347044;5893.410658934073;5907.645541267538;5911.349751527415;5806.65160090396;5836.328822185334;5858.121281807763;5867.295924489089;5874;5580.888382232414;5713;5757.884842303214;5780.161876527795;5791.768329266951;5827.475527202402;5856.355800861987;5877.911831322448;5888.087346461305;5893.734781934738;5657.773689052392;5746.051901436384;5747.396523364986;5748.137779333133;5763.769449221984 04:31:58 INFO - PROCESS | 19100 | |1;ext.html;673.9022841687954;675.0953722012503;677.3565113142516;683.8187880211743;734.6216698400322;32480;33094.83452582737;40196.1960760785;40876.59123408765;40980;43375.78312108435;43857.7807110964;43952.3407148893;43992;44042.779786101106;8024.037115546143;8798.999999999984;8948.8657670135;8971.147740964598;10424.791504169913;10422.322549034327;10554.736131596695;10564.366138031704;10566.154707623371;10567.10179634728;10604.734881627945;10677.039066484014;10684.893151068467;10685.732856678567;10686.251962362638;10498.422586757726;10553.84169237462;10561.471926403648;10562.524686389132;10564.418956957365;10518.368897866152;10645.680629581126;10652.573897044109;10987.285826421337;10991.06575941046;44275.33586996198;44755;44786.55213447857;44808.55191448076;44819.32771008405;3927.8036098194975;4013.3578627419474;4076.164386300801;4100.138970816132;4222.91554168918;34195.14512137192;34411.311773764384;34557.481637775454;34683.6531634683;36065.278694426226;4579.519150489184;4588.7476188809605;4617.607503362218;4636.281376386665;4669.229577119771;337110;340530;341280;341331;341488;39242.80378598089;60934.695326523084;61851;61979.380206198264;62092;37710.62289377126;37920.62079379226;37925.81037094852;37928.62071379306;37952;17102.401415950382;17291.39480118215;17294.65410691779;17309.91345043267;17318;12319.260844349368;13788;14043.78934315986;14047.438102475991;14053.508127215498;9150;9160.770980725401;9174.908250917539;9237.722868313962;9266.166045055978;3451.8101504416995;3571.607123216444;3592.7305452091196;3633.364161271767;3641.417373220325;1091.3942761767296;1141.965741027754;1147.9540818367338;1224.6264889208699;1285.884270415667;33880.32239355249;33974.49038264428;34033;34063.82968085193;34964.47553286703;1218.9085818563465;1258.5783762439503;1293.890019348347;1302.0560093931824;1339.5713371721151;16291.837081629032;16320;16372.263248153862;16709.331626734795;16801.747973780402;470586;476860;479030;479187;480672;59386.70306648439;60821.39178608157;60905;60906;60956.695216523636;1408.1128888800195;1532.4176812811284;1568.8823338249676;1582.3354191239707;1610.1949025487256;30290.545641815832;31493.527597085606;31770.841145794122;31872.681273186972;32027.039188824372;51247.48752512427;52042.47957520376;52109.47890521198;52458.47541524689;52493.47506524886;377745;378107;380240;380381;380457;26831.731682683705;29273.414531708822;29648;29650.851745741133;29933.550996735503;43175.35236971385;43695.56304436915;44128.77935610301;44312.556874432135;44400.76635198607;37738.03750606147;40031.59968400279;40044.59955400409;40906.1818763629;41012.38481422721;38855.41716874306;40424.39363409492;40596.738269280155;40875.38686919758;41130.177396451305;40465.39301910532;41324.1735165301;41395;42232.57767422409;42312.153756925305;35034.474482883285;36102.27795444129;36254.637453625124;36323.45514817333;36812.63187368199;27998.86000569984;28078.43843123167;28126.578101328905;28407.573886392132;28415.857920710263 04:31:58 INFO - PROCESS | 19100 | |2;jquery.html;424.1284161049043;424.69315428060224;434.15556742136556;434.3072798885777;440.0287406159411;18155.273789048457;18239.81760182398;18500.628338045877;18861;18892.149853256604;19182.944938028402;19258.614827703437;19291.614167716638;19726.506837329038;19734.407967760955;5747.109198074305;5853.999999999989;5926.229590153274;5945.940540594582;6015.608985415955;5897.056470964647;5906.704664766766;5908;5914.4381283777975;5954.9404505955035;5786.623869448473;5853.50245229156;5916.704164791743;5917.9408205918035;5919.585629005971;5841.970790146043;5853.034249348852;5853.32686741026;5865.413458654143;5894.58737888348;5315.096433606258;5323.893522129574;5654.547636189095;5913;5928.051511758098;14062.367193476319;14120.92939535306;14252.786208206886;14861.851381486154;22456.214032508946;2441.523902838947;2479.1199124310792;3011.849407529615;3031.4846476098896;3053.4503789317914;10096;10149.64476243328;10605.46972651372;12539.435725392288;14000.579982600539;1983.8908860012693;1996.780354161041;2051.507638166844;2104.4949212188963;2116.121809449077;71673;79510;81317.59341203315;81334.59332703298;83512;10405.739856503496;10496.842547361795;10498.370097794157;10554.788904221872;10630.362178269328;14106.506272280421;14178.503752368824;14193.148411095368;14198;14204.218767967861;8368.456050356708;8388.454750441324;8389;8455.788605284917;8473.745787626382;8575.485470871768;8987.595558199897;8990.775230619287;9094.590743416562;9117.77205569866;4359.084592235603;4365;4382.386465894777;4400.075984043323;4413.3159360299205;1837.2232196289806;2052.784457631957;2067.7725450200464;2099.9790002099785;2111.092230340968;995.711243739322;1030.9845352319721;1055.889131641182;1059.2055958031476;1085.2728671789919;17663.205155767766;17774.91112544429;18091;18105.728414073536;18387.988660623527;1002.8946960569181;1020.285799940045;1031.8710161229847;1056.8573242612304;1066.983995240072;10040.899591003996;10853.294535855144;10866.402347870942;10874.456277186267;10911.345319280868;443931;455515;460622;461703;464133;77741.83387249196;90929;91659.54170229106;92258;92911;1087.7715679707192;1088.4285749981323;1096.6874440784497;1103.0128035408266;1105.5577768892508;16986.235619397405;17007;17008.574785629964;17078.231479583697;17349.653006939538;40026.799866001646;40611.18777624372;40805;41135.38296925489;41219.7939010303;56451.71774141103;56822;56965.43034569601;57177.14234286572;57363.426365737476;8559.657613695383;8782.385233033881;8839.690610828848;8932.46405215689;8955.41789783662;12115.212511187097;12975.740485190432;13404.195748255135;13460.394282257517;13856.584302470941;12175.695607609881;12317;12388.256704597392;12399.504019839105;12719.491220351083;10718.928107189218;11984.76030479403;12084.214526055779;12104.939475302566;12605.49578016869;12393;12443.191192572454;12586.685332866751;12600.306983116017;12674;9143.862842057242;9208.677696280598;9242.815143697222;9255.76860578491;9429.434233945985;11135.498902549567;12063;12314.568990085663;12395.62813115608;12451.75096498083 04:31:58 INFO - PROCESS | 19100 | |3;mootools.html;1453.476748370587;1594.147131284763;1597.1614902176357;1787.9106044697762;1917;7832.138464768878;8480.363972702049;8594.398392112555;8613.353998450126;8615.31077513799;8432.704855330065;8589.09814469481;8604;8612.052674205848;8621.05168431472;2103.3059090500174;2146.5170336674278;2150.354893531942;2392.5214957008625;2417.02110645189;2397.6643269942224;2458.4345600511892;2469.345623409789;2471.233917485576;2472.2088931541825;2335.089315167086;2337.5792357375667;2346.835721499496;2357.068957761683;2415.3237093613816;2072.3057775645175;2319.3389883883183;2423.4547226873988;2429.6841410616594;2429.757024297574;2326.7789559991775;2366.0535785685693;2368.2539999899977;2369.609014512603;2369.9289021329387;8489.278411335044;8535.103814099492;8536.914630853675;8550.444221125606;8562.785930351729;5388;5466.781328746885;5502.889942201174;5506.724663766796;5507.421720719307;3446.327966046622;3517.296540691872;3603.873864414733;3652.7625704329134;3652.8721494747824;1158.0272571040366;1163.8894305041008;1197.114135539703;1202.9157958942878;1222.4315693202614;12511;12571.559995400117;12592.559260425933;12593.37033148339;12594.937025314906;4870.853874383774;4878.82924097662;4987.376577927759;4996.90006199874;5010.248462730547;10582.57669693219;10649;10661.733456663645;10663.253572249869;10668.519916603771;5674.177244299636;5679.6876171810945;5681.914771278434;5684.34630017545;5687.744051517691;4551.817927282872;4940.580050695659;5085.466026067284;5174.43081261061;5183.714895680774;4193.727407718488;4194.748315101104;4217.261979153636;4278.0374415756205;4291.570842915746;1360.6530334764573;1385.4804448331874;1385.902986790915;1387.1538361599416;1404.5841153216452;896.4576431259125;954.961801527945;1023.4268809466722;1027.4965267019106;1055.8680164979378;5904.822855314347;6025.186599809057;6058.485028772604;6068.180795592627;6112.633242005405;474.27909577442784;485.3956823754378;487.30558953491135;493.8197557891344;497.1300224606938;4028.617281358266;4150.501939767248;4158.397032430281;4180.289350810309;4192.161567686414;10684.358938463716;10819.026287634151;10838.458077096113;10999.285046471954;10999.505022274017;10113.190944724405;10673.786524269472;10821.404822734668;10841.403722795321;10862.185336099825;8228.177182281725;8297.211764882326;8405.95797021011;8407.201315874981;8427.747167584983;5849.502792262705;5989.131575921554;6021.54838387114;6056.878862422639;6226.875462490815;9425.481598512148;9590.616375344907;9678.27412944046;9705.078017588317;9712.271579631415;9351.85972210431;9566.378185417925;9779.364341317792;9798.902010979798;9883.95058024734;7394.2975417335265;7967.721129760663;8145.959270203611;8221.054578723524;8300.377471689768;8312.127226641116;8321.12628174033;8367.497950123012;8372.037215720271;8375.874361884698;7373.741919032808;7604.353629941517;7625.6949722010495;7638.770836874903;7742.070951485858;7442.181360050498;7471.290227428385;7480.92519074824;7570.848583028419;7574.242575742602;6989.930100699131;7033.788986330418;7156.069710937545;7188.101487314086;7194.784156475314;5195.376554813447;5223.3209682741;5338.412774594869;5364.8122315718765;5402.486763757437;5213.348331458567;5363.19552067193;5386.245925570502;5421.2139239810795;5425.83722488326 04:31:58 INFO - PROCESS | 19100 | |4;prototype.html;362.5540585080349;364.33872521373706;365.95242618459594;367.36079222153455;370.51092557823665;6143.324234334225;6148.692565371724;6174.197354343929;6190.226221722285;6196.2564492260935;5903.055511118222;6123.234595675541;6128.172696685946;6144.539159563028;6150.384961503847;4687.9296810547785;4753.811547113221;4781.593564547;4789.544993225655;4801.18379875422;4765.976170119145;4786.114568804782;4792.9760351198365;4800.063987522434;4806.4472585652575;4587.72473651582;4664.743439110847;4755.90488190236;4760.4525479569775;4783.282507623867;4747.406574178228;4756.738379389132;4762.333273341735;4780.784864681063;4794.904101917959;4163.458750362463;4165.500139983191;4187.895302617429;4218.325067989138;4219.092895027584;5929.466348028698;5933.110033494967;5936.495397891184;5938.406159384071;5938.703064846741;5587.525060369873;5591.10542313232;5591.133374326986;5592.552595792326;5593.944060559383;6318.842028949313;6532.771353002622;6571.31001244872;6571.901421478682;6577.079208910756;4536.432945881765;4560.612347950429;4561.338605902126;4561.794719237642;4562.110388474249;6835.248122706498;6905.447564194903;6909.689063992132;6915;6925;4621.491635920046;4624.630029597692;4625.907481850411;4626.282926146453;4627.467841198238;4699.177643912301;4699.530046995274;4700.576948074689;4705.035467729176;4709.270063140219;5445.1015582429245;5447.400785913546;5452.209429632681;5454.400015998237;5456;6476.805695829038;6598.406143447113;6620.702068406933;6622.139121914121;6622.503312251601;1643.926023328953;1653.3221379234456;1660.0620649333089;1660.692771837214;1662.7755253040684;1039.6380741229013;1071.2287153249647;1089.7384627689298;1099.3623698254994;1109.1237922041657;6361.109444677749;6424.421802037839;6431.260405053479;6438;6439.356064393617;6784.287649796799;6785.796426107225;6792.08306878575;6793.626350550767;6797;6433.581817181868;6436.742530298736;6437.130987316746;6437.903431448532;6441.194850643669;3583.5341405617105;3618.095476130967;3654.3056819204267;3659.670629643345;3665.0470877572025;7094.92905070953;7099.787006389816;7102.538335008208;7103.360697537247;7104.0764700589625;6884.345987131214;6926.861462770717;6929.3070692930305;6930.584164950119;6930.688119034656;7059.611721355374;7075.2570980047385;7080.787576372717;7088.7518936838;7092.219855815856;6744.595324280559;6747.595144291358;6748.898766518604;6753;6756.290589488033;6591.967040164768;6817.5909445433435;6823.590584564743;6827.112475378169;6827.112475378169;7192.100987376578;7232.349088582053;7234.529755565872;7237.240089790496;7247.4926755126635;4568.862934111849;4592.678512504092;4596.356510088657;4609.769511524478;4610.124076425603;6828.214755303204;6829.624370659462;6888.827779305558;6890.10428644273;6893.586384816927;6549.574277671936;6677.565958212701;6725.19297684281;6728.562643428358;6730.091437655854;6655.201375834931;6665.500087493554;6668.766593169215;6674.299198584079;6675.098861653809;6522.543421960418;6523.869522609616;6535.477161826947;6541.6402097883165;6571.80284591463;6721.327867213239;6726.461883049246;6726.529142960141;6732.831679208059;6744.190697116377;6428.260750013808;6592.143021407186;6658.600483970978;6661.866762664817;6667.366600172976 04:31:58 INFO - PROCESS | 19100 | |5;yui.html;833.9708110216144;844.2444012608715;844.2697067037014;855.7946092937689;858.1590041759076;14534.854651453483;14540.927295363508;14600.561983140497;14620.122792632435;15197.772033419495;12712.682182945431;14198.858011419883;14265.358058887348;14268;14290.14259144452;886.0430734806409;912.9041450647686;924.5793164110347;925.2413021322518;925.708401853414;913.2191975860643;914.8993610702818;917.1424717888762;923.3951761596165;924.9583768730423;776.6427443376053;958.0132463562542;961.528850863079;961.5480724059715;962.8074385123003;943.3632298198722;950.8383574792233;959.5010594490826;959.8608201810698;961.2790407194605;704.5983789240136;704.7991322473122;704.9718011279542;705.456798265338;706.0715159565156;14288.92855535726;14357.78463323051;14381.928090359586;14434.927825360806;14435.133891966516;13969.441222351094;14353.067050641675;14370.281485925661;14639.268036598234;14818.555443336718;12180.390980450942;12206.328651924141;12459.439325230296;12500.874991250063;12550.309732964683;4063.6342729154517;4076.32740597801;4108.5275193352845;4111.48606424197;4145.274576949052;54143;54188;54250.186247206715;54343.72828135874;54922;11166.203490813163;11434.542618295342;11670.94164529172;11697.941510292394;11731.530738770523;19871.701924471145;20330.186792528428;20371;20407.591848162952;20676;8905.064968178378;8923.866142007875;8943.329250306122;9008.774780630536;9016.459012459274;5005.72468514228;5097.515736005073;5139.922901156486;5157.097507936096;5166.302549155891;3690.8892733218045;3731.738778285548;3738.4018557030745;3740.2706472238197;3741.1582393961685;630.9305976342598;653.2520264297353;654.8821212181758;665.8768127896354;667.3093348384399;813.4875028731861;820.6553247636007;841.7853447371003;843.9662413503391;851.29342645604;10215.23385746072;10314.742131446625;10391.792164156675;10442.2168337375;10543.367397956146;762.142589586715;775.4261846233859;778.8052986753312;792.7582087463263;805.379857509726;4816.783244753994;4833.081714474239;4843;4851.56335929768;4891.119598472309;53026;57553;57866.7106664464;58089;61024.389756102755;50881;51454.48545514572;52383.47616523786;52636.47363526392;57005.14492282619;50958;51071.489285106676;52245.47754522482;52781.47218527766;52818.47181528136;10461.424621645883;10748.677539673823;10782.191335650015;10886.836697449386;10916.727081823017;38499;38789.41815872708;39420.60579394169;40545.594544054184;40987.18025639411;46171.76914115408;51221.231681525554;51325.74337128291;51856.48143518517;52056.47943520516;13067.215967042008;13092.934535327644;13140.934295328461;13375.197488150741;13390.26353550564;14226.928865355607;14578.125312481285;14596;14626.561203163923;14807.555773326818;10848.403337816495;12905.612831615066;12957.149466918016;13688.178709277476;13983.720325593635;13340.132891362031;13708.451661933412;13780.173189608655;14087.084339517898;14235.217063061631;12845.550405735754;13072.607821765363;13575.79636305476;13870.514531991332;14248.857511425167;10889.564417423215;11030.227884048361;11238.325700458;11410.372429516456;11636.883631163919;11587.362695051515;11904.440545282805;12007.339596322287;12079.939600301943;12090.274583524664 04:31:58 INFO - PROCESS | 19100 | __end_tp_report 04:31:58 INFO - PROCESS | 19100 | __start_cc_report 04:31:58 INFO - PROCESS | 19100 | _x_x_mozilla_cycle_collect,807 04:31:58 INFO - PROCESS | 19100 | __end_cc_report 04:31:58 INFO - PROCESS | 19100 | __startTimestamp1465039918016__endTimestamp 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | ------- Summary: start ------- 04:31:58 INFO - PROCESS | 19100 | Number of tests: 6 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | [#0] dojo.html Cycles:165 Average:5551.56 Median:5765.91 stddev:617.51 (10.7%) stddev-sans-first:593.04 04:31:58 INFO - PROCESS | 19100 | Values: 3276.0 3377.1 3395.4 3427.6 3437.1 5577.9 5580.8 5584.6 5623.5 5625.3 5560.9 5612.8 5618.8 5622.2 5630.1 4971.3 5034.4 5061.7 5110.6 5171.8 4956.2 4989.2 5018.2 5035.9 5039.5 5026.0 5057.8 5095.4 5111.7 5124.6 5119.8 5171.1 5174.3 5177.4 5213.2 4920.1 4978.9 5054.7 5063.7 5074.8 5434.8 5444.0 5478.0 5478.8 5502.0 5904.6 5906.8 5914.5 5919.4 5923.0 5981.7 6003.4 6103.0 6128.1 6137.1 5552.1 5593.6 5600.9 5601.9 5609.2 5980.5 6091.8 6096.8 6100.1 6109.3 5869.9 5911.2 5932.9 5942.6 5942.8 5954.5 5964.3 5965.5 5965.8 5967.6 5784.1 5898.9 5913.1 5915.5 5921.8 5936.1 5952.4 5957.6 5960.6 6002.6 4532.4 4540.9 4545.6 4547.0 4570.0 3975.1 4041.2 4071.1 4086.0 4117.4 5660.4 5688.4 5689.1 5693.1 5714.7 5936.6 5964.8 5988.2 5989.0 5989.5 5503.9 5643.2 5646.4 5698.9 5792.4 5161.2 5162.7 5163.8 5166.4 5190.2 6190.6 6207.5 6208.3 6211.3 6213.1 5887.3 5976.6 5977.0 6000.0 6051.9 6191.0 6197.0 6229.0 6232.4 6232.8 5900.0 5927.1 5929.6 5932.7 5963.4 5765.9 5919.3 5978.2 5979.3 5981.1 5845.8 5867.9 5893.4 5907.6 5911.3 5806.7 5836.3 5858.1 5867.3 5874.0 5580.9 5713.0 5757.9 5780.2 5791.8 5827.5 5856.4 5877.9 5888.1 5893.7 5657.8 5746.1 5747.4 5748.1 5763.8 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | [#1] ext.html Cycles:180 Average:55988.55 Median:3637.39 stddev:106476.43 (2927.3%) stddev-sans-first:106694.13 04:31:58 INFO - PROCESS | 19100 | Values: 673.9 675.1 677.4 683.8 734.6 32480.0 33094.8 40196.2 40876.6 40980.0 43375.8 43857.8 43952.3 43992.0 44042.8 8024.0 8799.0 8948.9 8971.1 10424.8 10422.3 10554.7 10564.4 10566.2 10567.1 10604.7 10677.0 10684.9 10685.7 10686.3 10498.4 10553.8 10561.5 10562.5 10564.4 10518.4 10645.7 10652.6 10987.3 10991.1 44275.3 44755.0 44786.6 44808.6 44819.3 3927.8 4013.4 4076.2 4100.1 4222.9 34195.1 34411.3 34557.5 34683.7 36065.3 4579.5 4588.7 4617.6 4636.3 4669.2 337110.0 340530.0 341280.0 341331.0 341488.0 39242.8 60934.7 61851.0 61979.4 62092.0 37710.6 37920.6 37925.8 37928.6 37952.0 17102.4 17291.4 17294.7 17309.9 17318.0 12319.3 13788.0 14043.8 14047.4 14053.5 9150.0 9160.8 9174.9 9237.7 9266.2 3451.8 3571.6 3592.7 3633.4 3641.4 1091.4 1142.0 1148.0 1224.6 1285.9 33880.3 33974.5 34033.0 34063.8 34964.5 1218.9 1258.6 1293.9 1302.1 1339.6 16291.8 16320.0 16372.3 16709.3 16801.7 470586.0 476860.0 479030.0 479187.0 480672.0 59386.7 60821.4 60905.0 60906.0 60956.7 1408.1 1532.4 1568.9 1582.3 1610.2 30290.5 31493.5 31770.8 31872.7 32027.0 51247.5 52042.5 52109.5 52458.5 52493.5 377745.0 378107.0 380240.0 380381.0 380457.0 26831.7 29273.4 29648.0 29650.9 29933.6 43175.4 43695.6 44128.8 44312.6 44400.8 37738.0 40031.6 40044.6 40906.2 41012.4 38855.4 40424.4 40596.7 40875.4 41130.2 40465.4 41324.2 41395.0 42232.6 42312.2 35034.5 36102.3 36254.6 36323.5 36812.6 27998.9 28078.4 28126.6 28407.6 28415.9 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | [#2] jquery.html Cycles:180 Average:27803.63 Median:2107.79 stddev:75469.76 (3580.5%) stddev-sans-first:75653.48 04:31:58 INFO - PROCESS | 19100 | Values: 424.1 424.7 434.2 434.3 440.0 18155.3 18239.8 18500.6 18861.0 18892.1 19182.9 19258.6 19291.6 19726.5 19734.4 5747.1 5854.0 5926.2 5945.9 6015.6 5897.1 5906.7 5908.0 5914.4 5954.9 5786.6 5853.5 5916.7 5917.9 5919.6 5842.0 5853.0 5853.3 5865.4 5894.6 5315.1 5323.9 5654.5 5913.0 5928.1 14062.4 14120.9 14252.8 14861.9 22456.2 2441.5 2479.1 3011.8 3031.5 3053.5 10096.0 10149.6 10605.5 12539.4 14000.6 1983.9 1996.8 2051.5 2104.5 2116.1 71673.0 79510.0 81317.6 81334.6 83512.0 10405.7 10496.8 10498.4 10554.8 10630.4 14106.5 14178.5 14193.1 14198.0 14204.2 8368.5 8388.5 8389.0 8455.8 8473.7 8575.5 8987.6 8990.8 9094.6 9117.8 4359.1 4365.0 4382.4 4400.1 4413.3 1837.2 2052.8 2067.8 2100.0 2111.1 995.7 1031.0 1055.9 1059.2 1085.3 17663.2 17774.9 18091.0 18105.7 18388.0 1002.9 1020.3 1031.9 1056.9 1067.0 10040.9 10853.3 10866.4 10874.5 10911.3 443931.0 455515.0 460622.0 461703.0 464133.0 77741.8 90929.0 91659.5 92258.0 92911.0 1087.8 1088.4 1096.7 1103.0 1105.6 16986.2 17007.0 17008.6 17078.2 17349.7 40026.8 40611.2 40805.0 41135.4 41219.8 56451.7 56822.0 56965.4 57177.1 57363.4 8559.7 8782.4 8839.7 8932.5 8955.4 12115.2 12975.7 13404.2 13460.4 13856.6 12175.7 12317.0 12388.3 12399.5 12719.5 10718.9 11984.8 12084.2 12104.9 12605.5 12393.0 12443.2 12586.7 12600.3 12674.0 9143.9 9208.7 9242.8 9255.8 9429.4 11135.5 12063.0 12314.6 12395.6 12451.8 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | [#3] mootools.html Cycles:180 Average:5826.44 Median:5129.95 stddev:3247.48 (63.3%) stddev-sans-first:3239.96 04:31:58 INFO - PROCESS | 19100 | Values: 1453.5 1594.1 1597.2 1787.9 1917.0 7832.1 8480.4 8594.4 8613.4 8615.3 8432.7 8589.1 8604.0 8612.1 8621.1 2103.3 2146.5 2150.4 2392.5 2417.0 2397.7 2458.4 2469.3 2471.2 2472.2 2335.1 2337.6 2346.8 2357.1 2415.3 2072.3 2319.3 2423.5 2429.7 2429.8 2326.8 2366.1 2368.3 2369.6 2369.9 8489.3 8535.1 8536.9 8550.4 8562.8 5388.0 5466.8 5502.9 5506.7 5507.4 3446.3 3517.3 3603.9 3652.8 3652.9 1158.0 1163.9 1197.1 1202.9 1222.4 12511.0 12571.6 12592.6 12593.4 12594.9 4870.9 4878.8 4987.4 4996.9 5010.2 10582.6 10649.0 10661.7 10663.3 10668.5 5674.2 5679.7 5681.9 5684.3 5687.7 4551.8 4940.6 5085.5 5174.4 5183.7 4193.7 4194.7 4217.3 4278.0 4291.6 1360.7 1385.5 1385.9 1387.2 1404.6 896.5 955.0 1023.4 1027.5 1055.9 5904.8 6025.2 6058.5 6068.2 6112.6 474.3 485.4 487.3 493.8 497.1 4028.6 4150.5 4158.4 4180.3 4192.2 10684.4 10819.0 10838.5 10999.3 10999.5 10113.2 10673.8 10821.4 10841.4 10862.2 8228.2 8297.2 8406.0 8407.2 8427.7 5849.5 5989.1 6021.5 6056.9 6226.9 9425.5 9590.6 9678.3 9705.1 9712.3 9351.9 9566.4 9779.4 9798.9 9884.0 7394.3 7967.7 8146.0 8221.1 8300.4 8312.1 8321.1 8367.5 8372.0 8375.9 7373.7 7604.4 7625.7 7638.8 7742.1 7442.2 7471.3 7480.9 7570.8 7574.2 6989.9 7033.8 7156.1 7188.1 7194.8 5195.4 5223.3 5338.4 5364.8 5402.5 5213.3 5363.2 5386.2 5421.2 5425.8 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | [#4] prototype.html Cycles:180 Average:5535.34 Median:6339.98 stddev:1683.09 (26.5%) stddev-sans-first:1642.42 04:31:58 INFO - PROCESS | 19100 | Values: 362.6 364.3 366.0 367.4 370.5 6143.3 6148.7 6174.2 6190.2 6196.3 5903.1 6123.2 6128.2 6144.5 6150.4 4687.9 4753.8 4781.6 4789.5 4801.2 4766.0 4786.1 4793.0 4800.1 4806.4 4587.7 4664.7 4755.9 4760.5 4783.3 4747.4 4756.7 4762.3 4780.8 4794.9 4163.5 4165.5 4187.9 4218.3 4219.1 5929.5 5933.1 5936.5 5938.4 5938.7 5587.5 5591.1 5591.1 5592.6 5593.9 6318.8 6532.8 6571.3 6571.9 6577.1 4536.4 4560.6 4561.3 4561.8 4562.1 6835.2 6905.4 6909.7 6915.0 6925.0 4621.5 4624.6 4625.9 4626.3 4627.5 4699.2 4699.5 4700.6 4705.0 4709.3 5445.1 5447.4 5452.2 5454.4 5456.0 6476.8 6598.4 6620.7 6622.1 6622.5 1643.9 1653.3 1660.1 1660.7 1662.8 1039.6 1071.2 1089.7 1099.4 1109.1 6361.1 6424.4 6431.3 6438.0 6439.4 6784.3 6785.8 6792.1 6793.6 6797.0 6433.6 6436.7 6437.1 6437.9 6441.2 3583.5 3618.1 3654.3 3659.7 3665.0 7094.9 7099.8 7102.5 7103.4 7104.1 6884.3 6926.9 6929.3 6930.6 6930.7 7059.6 7075.3 7080.8 7088.8 7092.2 6744.6 6747.6 6748.9 6753.0 6756.3 6592.0 6817.6 6823.6 6827.1 6827.1 7192.1 7232.3 7234.5 7237.2 7247.5 4568.9 4592.7 4596.4 4609.8 4610.1 6828.2 6829.6 6888.8 6890.1 6893.6 6549.6 6677.6 6725.2 6728.6 6730.1 6655.2 6665.5 6668.8 6674.3 6675.1 6522.5 6523.9 6535.5 6541.6 6571.8 6721.3 6726.5 6726.5 6732.8 6744.2 6428.3 6592.1 6658.6 6661.9 6667.4 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - PROCESS | 19100 | [#5] yui.html Cycles:180 Average:15422.82 Median:22531.75 stddev:17088.33 (75.8%) stddev-sans-first:17101.14 04:31:58 INFO - PROCESS | 19100 | Values: 834.0 844.2 844.3 855.8 858.2 14534.9 14540.9 14600.6 14620.1 15197.8 12712.7 14198.9 14265.4 14268.0 14290.1 886.0 912.9 924.6 925.2 925.7 913.2 914.9 917.1 923.4 925.0 776.6 958.0 961.5 961.5 962.8 943.4 950.8 959.5 959.9 961.3 704.6 704.8 705.0 705.5 706.1 14288.9 14357.8 14381.9 14434.9 14435.1 13969.4 14353.1 14370.3 14639.3 14818.6 12180.4 12206.3 12459.4 12500.9 12550.3 4063.6 4076.3 4108.5 4111.5 4145.3 54143.0 54188.0 54250.2 54343.7 54922.0 11166.2 11434.5 11670.9 11697.9 11731.5 19871.7 20330.2 20371.0 20407.6 20676.0 8905.1 8923.9 8943.3 9008.8 9016.5 5005.7 5097.5 5139.9 5157.1 5166.3 3690.9 3731.7 3738.4 3740.3 3741.2 630.9 653.3 654.9 665.9 667.3 813.5 820.7 841.8 844.0 851.3 10215.2 10314.7 10391.8 10442.2 10543.4 762.1 775.4 778.8 792.8 805.4 4816.8 4833.1 4843.0 4851.6 4891.1 53026.0 57553.0 57866.7 58089.0 61024.4 50881.0 51454.5 52383.5 52636.5 57005.1 50958.0 51071.5 52245.5 52781.5 52818.5 10461.4 10748.7 10782.2 10886.8 10916.7 38499.0 38789.4 39420.6 40545.6 40987.2 46171.8 51221.2 51325.7 51856.5 52056.5 13067.2 13092.9 13140.9 13375.2 13390.3 14226.9 14578.1 14596.0 14626.6 14807.6 10848.4 12905.6 12957.1 13688.2 13983.7 13340.1 13708.5 13780.2 14087.1 14235.2 12845.6 13072.6 13575.8 13870.5 14248.9 10889.6 11030.2 11238.3 11410.4 11636.9 11587.4 11904.4 12007.3 12079.9 12090.3 04:31:58 INFO - PROCESS | 19100 | -------- Summary: end -------- 04:31:58 INFO - PROCESS | 19100 | 04:31:58 INFO - TEST-INFO | 19100: exit 0 04:31:58 INFO - TEST-OK | dromaeo_css | took 1111298ms 04:31:58 INFO - TEST-START | kraken 04:31:58 INFO - operating with platform_type : linux_ 04:31:58 INFO - Initialising browser for kraken test... 04:31:58 INFO - TEST-INFO | started process 19288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTsAMTf/profile http://localhost:55697/getInfo.html) 04:32:02 INFO - PROCESS | 19288 | __metrics Screen width/height:1600/1200 04:32:02 INFO - PROCESS | 19288 | colorDepth:24 04:32:02 INFO - PROCESS | 19288 | Browser inner width/height: 1024/697 04:32:02 INFO - PROCESS | 19288 | __metrics 04:32:03 ERROR - PROCESS | 19288 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:32:04 INFO - TEST-INFO | 19288: exit 0 04:32:04 INFO - Browser initialized. 04:32:04 INFO - Running cycle 1/1 for kraken test... 04:32:04 INFO - TEST-INFO | started process 19380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTsAMTf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:16 INFO - PROCESS | 19380 | RSS: Main: 141590528 04:32:16 INFO - PROCESS | 19380 | 04:32:18 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55697/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:19 INFO - PROCESS | 19380 | RSS: Main: 196526080 04:32:19 INFO - PROCESS | 19380 | 04:32:21 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55697/tests/kraken/driver.html?testName=audio-dft) 04:32:22 INFO - PROCESS | 19380 | RSS: Main: 181219328 04:32:22 INFO - PROCESS | 19380 | 04:32:25 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55697/tests/kraken/driver.html?testName=audio-fft) 04:32:25 INFO - PROCESS | 19380 | RSS: Main: 272093184 04:32:25 INFO - PROCESS | 19380 | 04:32:28 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55697/tests/kraken/driver.html?testName=audio-oscillator) 04:32:28 INFO - PROCESS | 19380 | RSS: Main: 178405376 04:32:28 INFO - PROCESS | 19380 | 04:32:30 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:31 INFO - PROCESS | 19380 | RSS: Main: 177278976 04:32:31 INFO - PROCESS | 19380 | 04:32:34 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55697/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:34 INFO - PROCESS | 19380 | RSS: Main: 211587072 04:32:34 INFO - PROCESS | 19380 | 04:32:38 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55697/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:38 INFO - PROCESS | 19380 | RSS: Main: 211406848 04:32:38 INFO - PROCESS | 19380 | 04:32:41 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55697/tests/kraken/driver.html?testName=json-parse-financial) 04:32:42 INFO - PROCESS | 19380 | RSS: Main: 211189760 04:32:42 INFO - PROCESS | 19380 | 04:32:43 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:44 INFO - PROCESS | 19380 | RSS: Main: 190480384 04:32:44 INFO - PROCESS | 19380 | 04:32:46 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:46 INFO - PROCESS | 19380 | RSS: Main: 193687552 04:32:46 INFO - PROCESS | 19380 | 04:32:48 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:49 INFO - PROCESS | 19380 | RSS: Main: 206393344 04:32:49 INFO - PROCESS | 19380 | 04:32:51 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:52 INFO - PROCESS | 19380 | RSS: Main: 212119552 04:32:52 INFO - PROCESS | 19380 | 04:32:54 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:55 INFO - PROCESS | 19380 | RSS: Main: 208351232 04:32:55 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | Cycle 1(1): loaded http://localhost:55697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55697/tests/kraken/driver.html?testName=ai-astar) 04:32:57 INFO - PROCESS | 19380 | RSS: Main: 272424960 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | __start_tp_report 04:32:57 INFO - PROCESS | 19380 | _x_x_mozilla_page_load 04:32:57 INFO - PROCESS | 19380 | _x_x_mozilla_page_load_details 04:32:57 INFO - PROCESS | 19380 | |i|pagename|runs| 04:32:57 INFO - PROCESS | 19380 | |0;ai-astar;110;108;110;111;111;110;105;108;109;110 04:32:57 INFO - PROCESS | 19380 | |1;audio-beat-detection;153;126;151;181;133;155;162;129;174;126 04:32:57 INFO - PROCESS | 19380 | |2;audio-dft;161;160;159;164;162;159;160;160;160;162 04:32:57 INFO - PROCESS | 19380 | |3;audio-fft;75;77;77;166;75;77;75;75;167;76 04:32:57 INFO - PROCESS | 19380 | |4;audio-oscillator;93;93;148;91;92;93;146;92;92;150 04:32:57 INFO - PROCESS | 19380 | |5;imaging-gaussian-blur;116;117;116;118;117;116;116;116;116;117 04:32:57 INFO - PROCESS | 19380 | |6;imaging-darkroom;145;146;145;145;146;145;145;146;145;145 04:32:57 INFO - PROCESS | 19380 | |7;imaging-desaturate;94;94;94;95;95;95;96;95;95;95 04:32:57 INFO - PROCESS | 19380 | |8;json-parse-financial;56;63;54;54;56;56;55;76;54;54 04:32:57 INFO - PROCESS | 19380 | |9;json-stringify-tinderbox;59;57;58;57;58;57;58;57;56;58 04:32:57 INFO - PROCESS | 19380 | |10;stanford-crypto-aes;72;72;72;72;73;73;73;79;72;73 04:32:57 INFO - PROCESS | 19380 | |11;stanford-crypto-ccm;115;117;114;114;115;111;116;116;129;128 04:32:57 INFO - PROCESS | 19380 | |12;stanford-crypto-pbkdf2;168;159;161;163;160;161;157;170;159;159 04:32:57 INFO - PROCESS | 19380 | |13;stanford-crypto-sha256-iterative;68;66;66;73;67;78;65;66;65;65 04:32:57 INFO - PROCESS | 19380 | __end_tp_report 04:32:57 INFO - PROCESS | 19380 | __start_cc_report 04:32:57 INFO - PROCESS | 19380 | _x_x_mozilla_cycle_collect,1584 04:32:57 INFO - PROCESS | 19380 | __end_cc_report 04:32:57 INFO - PROCESS | 19380 | __startTimestamp1465039977524__endTimestamp 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | ------- Summary: start ------- 04:32:57 INFO - PROCESS | 19380 | Number of tests: 14 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 04:32:57 INFO - PROCESS | 19380 | Values: 110.0 108.0 110.0 111.0 111.0 110.0 105.0 108.0 109.0 110.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.00 stddev:19.97 (13.0%) stddev-sans-first:21.13 04:32:57 INFO - PROCESS | 19380 | Values: 153.0 126.0 151.0 181.0 133.0 155.0 162.0 129.0 174.0 126.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.57 (1.0%) stddev-sans-first:1.66 04:32:57 INFO - PROCESS | 19380 | Values: 161.0 160.0 159.0 164.0 162.0 159.0 160.0 160.0 160.0 162.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:38.22 (50.6%) stddev-sans-first:39.92 04:32:57 INFO - PROCESS | 19380 | Values: 75.0 77.0 77.0 166.0 75.0 77.0 75.0 75.0 167.0 76.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:26.94 (29.3%) stddev-sans-first:27.94 04:32:57 INFO - PROCESS | 19380 | Values: 93.0 93.0 148.0 91.0 92.0 93.0 146.0 92.0 92.0 150.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 04:32:57 INFO - PROCESS | 19380 | Values: 116.0 117.0 116.0 118.0 117.0 116.0 116.0 116.0 116.0 117.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:32:57 INFO - PROCESS | 19380 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 04:32:57 INFO - PROCESS | 19380 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:56.00 stddev:6.94 (12.4%) stddev-sans-first:7.33 04:32:57 INFO - PROCESS | 19380 | Values: 56.0 63.0 54.0 54.0 56.0 56.0 55.0 76.0 54.0 54.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.85 (1.5%) stddev-sans-first:0.71 04:32:57 INFO - PROCESS | 19380 | Values: 59.0 57.0 58.0 57.0 58.0 57.0 58.0 57.0 56.0 58.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:2.13 (2.9%) stddev-sans-first:2.22 04:32:57 INFO - PROCESS | 19380 | Values: 72.0 72.0 72.0 72.0 73.0 73.0 73.0 79.0 72.0 73.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:116.00 stddev:6.02 (5.2%) stddev-sans-first:6.32 04:32:57 INFO - PROCESS | 19380 | Values: 115.0 117.0 114.0 114.0 115.0 111.0 116.0 116.0 129.0 128.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.00 stddev:4.19 (2.6%) stddev-sans-first:3.77 04:32:57 INFO - PROCESS | 19380 | Values: 168.0 159.0 161.0 163.0 160.0 161.0 157.0 170.0 159.0 159.0 04:32:57 INFO - PROCESS | 19380 | 04:32:57 INFO - PROCESS | 19380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:66.50 stddev:4.28 (6.4%) stddev-sans-first:4.54 04:32:57 INFO - PROCESS | 19380 | Values: 68.0 66.0 66.0 73.0 67.0 78.0 65.0 66.0 65.0 65.0 04:32:57 INFO - PROCESS | 19380 | -------- Summary: end -------- 04:32:57 INFO - PROCESS | 19380 | 04:32:58 INFO - TEST-INFO | 19380: exit 0 04:32:58 INFO - TEST-OK | kraken | took 60000ms 04:32:58 INFO - SUITE-END | took 1171s 04:32:58 INFO - Completed test suite (00:19:31) 04:32:58 INFO - javascript benchmark 04:32:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.0499455158006, 3377.071305391017, 3395.354882572311, 3427.5886893572742, 3437.0548099272696, 5577.8605534861645, 5580.776768929243, 5584.58115641327, 5623.522000629946, 5625.268715067045, 5560.888782224353, 5612.803551875675, 5618.831435056944, 5622.184783206443, 5630.09918413054, 4971.304017437562, 5034.446210916796, 5061.746912654362, 5110.591152707793, 5171.844844654666, 4956.1822299320565, 4989.151844186479, 5018.222175562775, 5035.924461133068, 5039.546440820325, 5026.045051440233, 5057.77240024198, 5095.3885533736, 5111.718855462948, 5124.590032797368, 5119.820806271781, 5171.120909445403, 5174.275601415805, 5177.378714554277, 5213.1919552469235, 4920.138975679241, 4978.87552811179, 5054.7472626368535, 5063.696178229318, 5074.82238121664, 5434.7826086956475, 5443.972780136074, 5477.972610136963, 5478.808241711561, 5502.0371434999115, 5904.5571582131515, 5906.822795316148, 5914.497267732248, 5919.378465261172, 5923.022701254331, 5981.671008094553, 6003.3996600339615, 6103.0, 6128.111423843562, 6137.11011903276, 5552.08390615548, 5593.636413633101, 5600.859978500489, 5601.887962240732, 5609.214709940612, 5980.491658209101, 6091.756329746849, 6096.786612468542, 6100.054491553817, 6109.327973922865, 5869.853253668693, 5911.201987731687, 5932.911006334908, 5942.643441393444, 5942.762289508371, 5954.49386802118, 5964.314103878023, 5965.522758179335, 5965.7613695452565, 5967.6419414835245, 5784.074548072288, 5898.8820223595285, 5913.053911374245, 5915.497182739429, 5921.7631294747725, 5936.050231962865, 5952.404759524013, 5957.6127551709, 5960.552958528127, 6002.579819412686, 4532.365468834366, 4540.886477838015, 4545.6136228420955, 4546.954530454719, 4570.0, 3975.0658595230097, 4041.151358214749, 4071.1247081876945, 4085.9795701021303, 4117.382392641128, 5660.377358490645, 5688.374278829326, 5689.146628005832, 5693.146028095736, 5714.685692286964, 5936.5844390892225, 5964.7912323068485, 5988.191594134736, 5988.951933411636, 5989.490893274034, 5503.889922201533, 5643.1535269709875, 5646.350669672958, 5698.857528561819, 5792.4497172768515, 5161.225816127611, 5162.664426812245, 5163.845084647466, 5166.43169251382, 5190.24741412493, 6190.628562286277, 6207.534434917399, 6208.255009398811, 6211.3478084800445, 6213.099100630383, 5887.264091988502, 5976.64140151601, 5977.043673012297, 5999.970000149971, 6051.909221361771, 6191.0, 6196.969015154896, 6228.968855155696, 6232.407921247474, 6232.8130156095385, 5899.970500147472, 5927.110933360031, 5929.644221346733, 5932.733027013708, 5963.433473820153, 5765.91351129725, 5919.289685237799, 5978.192943952511, 5979.312379076462, 5981.102834574848, 5845.795397161079, 5867.882642347044, 5893.410658934073, 5907.645541267538, 5911.349751527415, 5806.65160090396, 5836.328822185334, 5858.121281807763, 5867.295924489089, 5874.0, 5580.888382232414, 5713.0, 5757.884842303214, 5780.161876527795, 5791.768329266951, 5827.475527202402, 5856.355800861987, 5877.911831322448, 5888.087346461305, 5893.734781934738, 5657.773689052392, 5746.051901436384, 5747.396523364986, 5748.137779333133, 5763.769449221984], "value": 5511.44290518135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.9022841687954, 675.0953722012503, 677.3565113142516, 683.8187880211743, 734.6216698400322, 32480.0, 33094.83452582737, 40196.1960760785, 40876.59123408765, 40980.0, 43375.78312108435, 43857.7807110964, 43952.3407148893, 43992.0, 44042.779786101106, 8024.037115546143, 8798.999999999984, 8948.8657670135, 8971.147740964598, 10424.791504169913, 10422.322549034327, 10554.736131596695, 10564.366138031704, 10566.154707623371, 10567.10179634728, 10604.734881627945, 10677.039066484014, 10684.893151068467, 10685.732856678567, 10686.251962362638, 10498.422586757726, 10553.84169237462, 10561.471926403648, 10562.524686389132, 10564.418956957365, 10518.368897866152, 10645.680629581126, 10652.573897044109, 10987.285826421337, 10991.06575941046, 44275.33586996198, 44755.0, 44786.55213447857, 44808.55191448076, 44819.32771008405, 3927.8036098194975, 4013.3578627419474, 4076.164386300801, 4100.138970816132, 4222.91554168918, 34195.14512137192, 34411.311773764384, 34557.481637775454, 34683.6531634683, 36065.278694426226, 4579.519150489184, 4588.7476188809605, 4617.607503362218, 4636.281376386665, 4669.229577119771, 337110.0, 340530.0, 341280.0, 341331.0, 341488.0, 39242.80378598089, 60934.695326523084, 61851.0, 61979.380206198264, 62092.0, 37710.62289377126, 37920.62079379226, 37925.81037094852, 37928.62071379306, 37952.0, 17102.401415950382, 17291.39480118215, 17294.65410691779, 17309.91345043267, 17318.0, 12319.260844349368, 13788.0, 14043.78934315986, 14047.438102475991, 14053.508127215498, 9150.0, 9160.770980725401, 9174.908250917539, 9237.722868313962, 9266.166045055978, 3451.8101504416995, 3571.607123216444, 3592.7305452091196, 3633.364161271767, 3641.417373220325, 1091.3942761767296, 1141.965741027754, 1147.9540818367338, 1224.6264889208699, 1285.884270415667, 33880.32239355249, 33974.49038264428, 34033.0, 34063.82968085193, 34964.47553286703, 1218.9085818563465, 1258.5783762439503, 1293.890019348347, 1302.0560093931824, 1339.5713371721151, 16291.837081629032, 16320.0, 16372.263248153862, 16709.331626734795, 16801.747973780402, 470586.0, 476860.0, 479030.0, 479187.0, 480672.0, 59386.70306648439, 60821.39178608157, 60905.0, 60906.0, 60956.695216523636, 1408.1128888800195, 1532.4176812811284, 1568.8823338249676, 1582.3354191239707, 1610.1949025487256, 30290.545641815832, 31493.527597085606, 31770.841145794122, 31872.681273186972, 32027.039188824372, 51247.48752512427, 52042.47957520376, 52109.47890521198, 52458.47541524689, 52493.47506524886, 377745.0, 378107.0, 380240.0, 380381.0, 380457.0, 26831.731682683705, 29273.414531708822, 29648.0, 29650.851745741133, 29933.550996735503, 43175.35236971385, 43695.56304436915, 44128.77935610301, 44312.556874432135, 44400.76635198607, 37738.03750606147, 40031.59968400279, 40044.59955400409, 40906.1818763629, 41012.38481422721, 38855.41716874306, 40424.39363409492, 40596.738269280155, 40875.38686919758, 41130.177396451305, 40465.39301910532, 41324.1735165301, 41395.0, 42232.57767422409, 42312.153756925305, 35034.474482883285, 36102.27795444129, 36254.637453625124, 36323.45514817333, 36812.63187368199, 27998.86000569984, 28078.43843123167, 28126.578101328905, 28407.573886392132, 28415.857920710263], "value": 19767.55903438457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.1284161049043, 424.69315428060224, 434.15556742136556, 434.3072798885777, 440.0287406159411, 18155.273789048457, 18239.81760182398, 18500.628338045877, 18861.0, 18892.149853256604, 19182.944938028402, 19258.614827703437, 19291.614167716638, 19726.506837329038, 19734.407967760955, 5747.109198074305, 5853.999999999989, 5926.229590153274, 5945.940540594582, 6015.608985415955, 5897.056470964647, 5906.704664766766, 5908.0, 5914.4381283777975, 5954.9404505955035, 5786.623869448473, 5853.50245229156, 5916.704164791743, 5917.9408205918035, 5919.585629005971, 5841.970790146043, 5853.034249348852, 5853.32686741026, 5865.413458654143, 5894.58737888348, 5315.096433606258, 5323.893522129574, 5654.547636189095, 5913.0, 5928.051511758098, 14062.367193476319, 14120.92939535306, 14252.786208206886, 14861.851381486154, 22456.214032508946, 2441.523902838947, 2479.1199124310792, 3011.849407529615, 3031.4846476098896, 3053.4503789317914, 10096.0, 10149.64476243328, 10605.46972651372, 12539.435725392288, 14000.579982600539, 1983.8908860012693, 1996.780354161041, 2051.507638166844, 2104.4949212188963, 2116.121809449077, 71673.0, 79510.0, 81317.59341203315, 81334.59332703298, 83512.0, 10405.739856503496, 10496.842547361795, 10498.370097794157, 10554.788904221872, 10630.362178269328, 14106.506272280421, 14178.503752368824, 14193.148411095368, 14198.0, 14204.218767967861, 8368.456050356708, 8388.454750441324, 8389.0, 8455.788605284917, 8473.745787626382, 8575.485470871768, 8987.595558199897, 8990.775230619287, 9094.590743416562, 9117.77205569866, 4359.084592235603, 4365.0, 4382.386465894777, 4400.075984043323, 4413.3159360299205, 1837.2232196289806, 2052.784457631957, 2067.7725450200464, 2099.9790002099785, 2111.092230340968, 995.711243739322, 1030.9845352319721, 1055.889131641182, 1059.2055958031476, 1085.2728671789919, 17663.205155767766, 17774.91112544429, 18091.0, 18105.728414073536, 18387.988660623527, 1002.8946960569181, 1020.285799940045, 1031.8710161229847, 1056.8573242612304, 1066.983995240072, 10040.899591003996, 10853.294535855144, 10866.402347870942, 10874.456277186267, 10911.345319280868, 443931.0, 455515.0, 460622.0, 461703.0, 464133.0, 77741.83387249196, 90929.0, 91659.54170229106, 92258.0, 92911.0, 1087.7715679707192, 1088.4285749981323, 1096.6874440784497, 1103.0128035408266, 1105.5577768892508, 16986.235619397405, 17007.0, 17008.574785629964, 17078.231479583697, 17349.653006939538, 40026.799866001646, 40611.18777624372, 40805.0, 41135.38296925489, 41219.7939010303, 56451.71774141103, 56822.0, 56965.43034569601, 57177.14234286572, 57363.426365737476, 8559.657613695383, 8782.385233033881, 8839.690610828848, 8932.46405215689, 8955.41789783662, 12115.212511187097, 12975.740485190432, 13404.195748255135, 13460.394282257517, 13856.584302470941, 12175.695607609881, 12317.0, 12388.256704597392, 12399.504019839105, 12719.491220351083, 10718.928107189218, 11984.76030479403, 12084.214526055779, 12104.939475302566, 12605.49578016869, 12393.0, 12443.191192572454, 12586.685332866751, 12600.306983116017, 12674.0, 9143.862842057242, 9208.677696280598, 9242.815143697222, 9255.76860578491, 9429.434233945985, 11135.498902549567, 12063.0, 12314.568990085663, 12395.62813115608, 12451.75096498083], "value": 9317.70778944732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.476748370587, 1594.147131284763, 1597.1614902176357, 1787.9106044697762, 1917.0, 7832.138464768878, 8480.363972702049, 8594.398392112555, 8613.353998450126, 8615.31077513799, 8432.704855330065, 8589.09814469481, 8604.0, 8612.052674205848, 8621.05168431472, 2103.3059090500174, 2146.5170336674278, 2150.354893531942, 2392.5214957008625, 2417.02110645189, 2397.6643269942224, 2458.4345600511892, 2469.345623409789, 2471.233917485576, 2472.2088931541825, 2335.089315167086, 2337.5792357375667, 2346.835721499496, 2357.068957761683, 2415.3237093613816, 2072.3057775645175, 2319.3389883883183, 2423.4547226873988, 2429.6841410616594, 2429.757024297574, 2326.7789559991775, 2366.0535785685693, 2368.2539999899977, 2369.609014512603, 2369.9289021329387, 8489.278411335044, 8535.103814099492, 8536.914630853675, 8550.444221125606, 8562.785930351729, 5388.0, 5466.781328746885, 5502.889942201174, 5506.724663766796, 5507.421720719307, 3446.327966046622, 3517.296540691872, 3603.873864414733, 3652.7625704329134, 3652.8721494747824, 1158.0272571040366, 1163.8894305041008, 1197.114135539703, 1202.9157958942878, 1222.4315693202614, 12511.0, 12571.559995400117, 12592.559260425933, 12593.37033148339, 12594.937025314906, 4870.853874383774, 4878.82924097662, 4987.376577927759, 4996.90006199874, 5010.248462730547, 10582.57669693219, 10649.0, 10661.733456663645, 10663.253572249869, 10668.519916603771, 5674.177244299636, 5679.6876171810945, 5681.914771278434, 5684.34630017545, 5687.744051517691, 4551.817927282872, 4940.580050695659, 5085.466026067284, 5174.43081261061, 5183.714895680774, 4193.727407718488, 4194.748315101104, 4217.261979153636, 4278.0374415756205, 4291.570842915746, 1360.6530334764573, 1385.4804448331874, 1385.902986790915, 1387.1538361599416, 1404.5841153216452, 896.4576431259125, 954.961801527945, 1023.4268809466722, 1027.4965267019106, 1055.8680164979378, 5904.822855314347, 6025.186599809057, 6058.485028772604, 6068.180795592627, 6112.633242005405, 474.27909577442784, 485.3956823754378, 487.30558953491135, 493.8197557891344, 497.1300224606938, 4028.617281358266, 4150.501939767248, 4158.397032430281, 4180.289350810309, 4192.161567686414, 10684.358938463716, 10819.026287634151, 10838.458077096113, 10999.285046471954, 10999.505022274017, 10113.190944724405, 10673.786524269472, 10821.404822734668, 10841.403722795321, 10862.185336099825, 8228.177182281725, 8297.211764882326, 8405.95797021011, 8407.201315874981, 8427.747167584983, 5849.502792262705, 5989.131575921554, 6021.54838387114, 6056.878862422639, 6226.875462490815, 9425.481598512148, 9590.616375344907, 9678.27412944046, 9705.078017588317, 9712.271579631415, 9351.85972210431, 9566.378185417925, 9779.364341317792, 9798.902010979798, 9883.95058024734, 7394.2975417335265, 7967.721129760663, 8145.959270203611, 8221.054578723524, 8300.377471689768, 8312.127226641116, 8321.12628174033, 8367.497950123012, 8372.037215720271, 8375.874361884698, 7373.741919032808, 7604.353629941517, 7625.6949722010495, 7638.770836874903, 7742.070951485858, 7442.181360050498, 7471.290227428385, 7480.92519074824, 7570.848583028419, 7574.242575742602, 6989.930100699131, 7033.788986330418, 7156.069710937545, 7188.101487314086, 7194.784156475314, 5195.376554813447, 5223.3209682741, 5338.412774594869, 5364.8122315718765, 5402.486763757437, 5213.348331458567, 5363.19552067193, 5386.245925570502, 5421.2139239810795, 5425.83722488326], "value": 4636.050439925947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.5540585080349, 364.33872521373706, 365.95242618459594, 367.36079222153455, 370.51092557823665, 6143.324234334225, 6148.692565371724, 6174.197354343929, 6190.226221722285, 6196.2564492260935, 5903.055511118222, 6123.234595675541, 6128.172696685946, 6144.539159563028, 6150.384961503847, 4687.9296810547785, 4753.811547113221, 4781.593564547, 4789.544993225655, 4801.18379875422, 4765.976170119145, 4786.114568804782, 4792.9760351198365, 4800.063987522434, 4806.4472585652575, 4587.72473651582, 4664.743439110847, 4755.90488190236, 4760.4525479569775, 4783.282507623867, 4747.406574178228, 4756.738379389132, 4762.333273341735, 4780.784864681063, 4794.904101917959, 4163.458750362463, 4165.500139983191, 4187.895302617429, 4218.325067989138, 4219.092895027584, 5929.466348028698, 5933.110033494967, 5936.495397891184, 5938.406159384071, 5938.703064846741, 5587.525060369873, 5591.10542313232, 5591.133374326986, 5592.552595792326, 5593.944060559383, 6318.842028949313, 6532.771353002622, 6571.31001244872, 6571.901421478682, 6577.079208910756, 4536.432945881765, 4560.612347950429, 4561.338605902126, 4561.794719237642, 4562.110388474249, 6835.248122706498, 6905.447564194903, 6909.689063992132, 6915.0, 6925.0, 4621.491635920046, 4624.630029597692, 4625.907481850411, 4626.282926146453, 4627.467841198238, 4699.177643912301, 4699.530046995274, 4700.576948074689, 4705.035467729176, 4709.270063140219, 5445.1015582429245, 5447.400785913546, 5452.209429632681, 5454.400015998237, 5456.0, 6476.805695829038, 6598.406143447113, 6620.702068406933, 6622.139121914121, 6622.503312251601, 1643.926023328953, 1653.3221379234456, 1660.0620649333089, 1660.692771837214, 1662.7755253040684, 1039.6380741229013, 1071.2287153249647, 1089.7384627689298, 1099.3623698254994, 1109.1237922041657, 6361.109444677749, 6424.421802037839, 6431.260405053479, 6438.0, 6439.356064393617, 6784.287649796799, 6785.796426107225, 6792.08306878575, 6793.626350550767, 6797.0, 6433.581817181868, 6436.742530298736, 6437.130987316746, 6437.903431448532, 6441.194850643669, 3583.5341405617105, 3618.095476130967, 3654.3056819204267, 3659.670629643345, 3665.0470877572025, 7094.92905070953, 7099.787006389816, 7102.538335008208, 7103.360697537247, 7104.0764700589625, 6884.345987131214, 6926.861462770717, 6929.3070692930305, 6930.584164950119, 6930.688119034656, 7059.611721355374, 7075.2570980047385, 7080.787576372717, 7088.7518936838, 7092.219855815856, 6744.595324280559, 6747.595144291358, 6748.898766518604, 6753.0, 6756.290589488033, 6591.967040164768, 6817.5909445433435, 6823.590584564743, 6827.112475378169, 6827.112475378169, 7192.100987376578, 7232.349088582053, 7234.529755565872, 7237.240089790496, 7247.4926755126635, 4568.862934111849, 4592.678512504092, 4596.356510088657, 4609.769511524478, 4610.124076425603, 6828.214755303204, 6829.624370659462, 6888.827779305558, 6890.10428644273, 6893.586384816927, 6549.574277671936, 6677.565958212701, 6725.19297684281, 6728.562643428358, 6730.091437655854, 6655.201375834931, 6665.500087493554, 6668.766593169215, 6674.299198584079, 6675.098861653809, 6522.543421960418, 6523.869522609616, 6535.477161826947, 6541.6402097883165, 6571.80284591463, 6721.327867213239, 6726.461883049246, 6726.529142960141, 6732.831679208059, 6744.190697116377, 6428.260750013808, 6592.143021407186, 6658.600483970978, 6661.866762664817, 6667.366600172976], "value": 4989.684615866808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.9708110216144, 844.2444012608715, 844.2697067037014, 855.7946092937689, 858.1590041759076, 14534.854651453483, 14540.927295363508, 14600.561983140497, 14620.122792632435, 15197.772033419495, 12712.682182945431, 14198.858011419883, 14265.358058887348, 14268.0, 14290.14259144452, 886.0430734806409, 912.9041450647686, 924.5793164110347, 925.2413021322518, 925.708401853414, 913.2191975860643, 914.8993610702818, 917.1424717888762, 923.3951761596165, 924.9583768730423, 776.6427443376053, 958.0132463562542, 961.528850863079, 961.5480724059715, 962.8074385123003, 943.3632298198722, 950.8383574792233, 959.5010594490826, 959.8608201810698, 961.2790407194605, 704.5983789240136, 704.7991322473122, 704.9718011279542, 705.456798265338, 706.0715159565156, 14288.92855535726, 14357.78463323051, 14381.928090359586, 14434.927825360806, 14435.133891966516, 13969.441222351094, 14353.067050641675, 14370.281485925661, 14639.268036598234, 14818.555443336718, 12180.390980450942, 12206.328651924141, 12459.439325230296, 12500.874991250063, 12550.309732964683, 4063.6342729154517, 4076.32740597801, 4108.5275193352845, 4111.48606424197, 4145.274576949052, 54143.0, 54188.0, 54250.186247206715, 54343.72828135874, 54922.0, 11166.203490813163, 11434.542618295342, 11670.94164529172, 11697.941510292394, 11731.530738770523, 19871.701924471145, 20330.186792528428, 20371.0, 20407.591848162952, 20676.0, 8905.064968178378, 8923.866142007875, 8943.329250306122, 9008.774780630536, 9016.459012459274, 5005.72468514228, 5097.515736005073, 5139.922901156486, 5157.097507936096, 5166.302549155891, 3690.8892733218045, 3731.738778285548, 3738.4018557030745, 3740.2706472238197, 3741.1582393961685, 630.9305976342598, 653.2520264297353, 654.8821212181758, 665.8768127896354, 667.3093348384399, 813.4875028731861, 820.6553247636007, 841.7853447371003, 843.9662413503391, 851.29342645604, 10215.23385746072, 10314.742131446625, 10391.792164156675, 10442.2168337375, 10543.367397956146, 762.142589586715, 775.4261846233859, 778.8052986753312, 792.7582087463263, 805.379857509726, 4816.783244753994, 4833.081714474239, 4843.0, 4851.56335929768, 4891.119598472309, 53026.0, 57553.0, 57866.7106664464, 58089.0, 61024.389756102755, 50881.0, 51454.48545514572, 52383.47616523786, 52636.47363526392, 57005.14492282619, 50958.0, 51071.489285106676, 52245.47754522482, 52781.47218527766, 52818.47181528136, 10461.424621645883, 10748.677539673823, 10782.191335650015, 10886.836697449386, 10916.727081823017, 38499.0, 38789.41815872708, 39420.60579394169, 40545.594544054184, 40987.18025639411, 46171.76914115408, 51221.231681525554, 51325.74337128291, 51856.48143518517, 52056.47943520516, 13067.215967042008, 13092.934535327644, 13140.934295328461, 13375.197488150741, 13390.26353550564, 14226.928865355607, 14578.125312481285, 14596.0, 14626.561203163923, 14807.555773326818, 10848.403337816495, 12905.612831615066, 12957.149466918016, 13688.178709277476, 13983.720325593635, 13340.132891362031, 13708.451661933412, 13780.173189608655, 14087.084339517898, 14235.217063061631, 12845.550405735754, 13072.607821765363, 13575.79636305476, 13870.514531991332, 14248.857511425167, 10889.564417423215, 11030.227884048361, 11238.325700458, 11410.372429516456, 11636.883631163919, 11587.362695051515, 11904.440545282805, 12007.339596322287, 12079.939600301943, 12090.274583524664], "value": 7254.2938693425685, "unit": "score"}], "name": "dromaeo_css", "value": 7445.553160152567, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 110.0, 111.0, 111.0, 110.0, 105.0, 108.0, 109.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 151.0, 181.0, 133.0, 155.0, 162.0, 129.0, 174.0, 126.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 164.0, 162.0, 159.0, 160.0, 160.0, 160.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 166.0, 75.0, 77.0, 75.0, 75.0, 167.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 148.0, 91.0, 92.0, 93.0, 146.0, 92.0, 92.0, 150.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 118.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 54.0, 54.0, 56.0, 56.0, 55.0, 76.0, 54.0, 54.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 58.0, 57.0, 58.0, 57.0, 58.0, 57.0, 56.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 73.0, 73.0, 79.0, 72.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 114.0, 114.0, 115.0, 111.0, 116.0, 116.0, 129.0, 128.0], "value": 117.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 159.0, 161.0, 163.0, 160.0, 161.0, 157.0, 170.0, 159.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 73.0, 67.0, 78.0, 65.0, 66.0, 65.0, 65.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1514.0, "alertThreshold": 2.0}]} 04:32:58 INFO - Return code: 0 04:32:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:32:58 ERROR - # TBPL SUCCESS # 04:32:58 INFO - Running post-action listener: _resource_record_post_action 04:32:58 INFO - Running post-run listener: _resource_record_post_run 04:32:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514396160; Read time: 12; Write time: 529096 04:32:59 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 266592256; Read time: 0; Write time: 368196 04:32:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247205888; Read time: 12; Write time: 160900 04:32:59 INFO - Running post-run listener: _upload_blobber_files 04:32:59 INFO - Blob upload gear active. 04:32:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:33:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:01 INFO - (blobuploader) - INFO - Done attempting. 04:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:01 INFO - (blobuploader) - INFO - Done attempting. 04:33:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:01 INFO - Return code: 0 04:33:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c94d7b89df307f206a763c0b73f338aaa5c300ba2fa15f991117ff0f616a1ad097506f3da3e25a119da652c67503851a2778956a48efda9be3e905e1c48e14a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e61f724f491071f42db2a7c983bbd7e84361b69d5bcc64c1400f8f9adcc6ff6eb6e35f9c824ecc5c1627d6fa1d340a0e03c919e715d58d592f316ad6262e737"} 04:33:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:01 INFO - Contents: 04:33:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c94d7b89df307f206a763c0b73f338aaa5c300ba2fa15f991117ff0f616a1ad097506f3da3e25a119da652c67503851a2778956a48efda9be3e905e1c48e14a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e61f724f491071f42db2a7c983bbd7e84361b69d5bcc64c1400f8f9adcc6ff6eb6e35f9c824ecc5c1627d6fa1d340a0e03c919e715d58d592f316ad6262e737"} 04:33:01 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:01 INFO - Copying logs to upload dir... 04:33:01 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.385956 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-04 04:33:01.501945) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:01.505811) ========= 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=41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c94d7b89df307f206a763c0b73f338aaa5c300ba2fa15f991117ff0f616a1ad097506f3da3e25a119da652c67503851a2778956a48efda9be3e905e1c48e14a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e61f724f491071f42db2a7c983bbd7e84361b69d5bcc64c1400f8f9adcc6ff6eb6e35f9c824ecc5c1627d6fa1d340a0e03c919e715d58d592f316ad6262e737"} build_url:https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011742 build_url: 'https://queue.taskcluster.net/v1/task/DZFcBeu5SuKtYg3snhng4Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c94d7b89df307f206a763c0b73f338aaa5c300ba2fa15f991117ff0f616a1ad097506f3da3e25a119da652c67503851a2778956a48efda9be3e905e1c48e14a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e61f724f491071f42db2a7c983bbd7e84361b69d5bcc64c1400f8f9adcc6ff6eb6e35f9c824ecc5c1627d6fa1d340a0e03c919e715d58d592f316ad6262e737"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:01.530729) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:01.531017) ========= 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=41bf3e9aed84707956354da8000001c5-1465028504.884026-1062697382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:01.616096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 04:33:01.616409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 04:33:01.616685) ========= ========= Total master_lag: 0.16 =========