builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1464431840.99 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:20.988327) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:20.988991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:20.989437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:21.004445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:21.004886) ========= 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=4300f881736b422476174874000001bc-1464431840.391827-1565704662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:37:21-- 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% 226M=0s 2016-05-28 03:37:21 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:21.098824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:21.099122) ========= 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=4300f881736b422476174874000001bc-1464431840.391827-1565704662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:21.148223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:37:21.148535) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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=4300f881736b422476174874000001bc-1464431840.391827-1565704662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:37:21,244 truncating revision to first 12 chars 2016-05-28 03:37:21,244 Setting DEBUG logging. 2016-05-28 03:37:21,244 attempt 1/10 2016-05-28 03:37:21,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33693d8bdec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:37:22,198 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:37:22.454229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:22.454889) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:22.455566) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:22.456085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:22.466719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-28 03:37:22.467004) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=4300f881736b422476174874000001bc-1464431840.391827-1565704662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:37:22 INFO - MultiFileLogger online at 20160528 03:37:22 in /builds/slave/test 03:37:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:37:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:37:22 INFO - {'append_to_log': False, 03:37:22 INFO - 'base_work_dir': '/builds/slave/test', 03:37:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:37:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:37:22 INFO - 'branch': 'Mozilla-Aurora', 03:37:22 INFO - 'buildbot_json_path': 'buildprops.json', 03:37:22 INFO - 'config_files': ('talos/linux_config.py',), 03:37:22 INFO - 'default_actions': ('clobber', 03:37:22 INFO - 'read-buildbot-config', 03:37:22 INFO - 'download-and-extract', 03:37:22 INFO - 'populate-webroot', 03:37:22 INFO - 'create-virtualenv', 03:37:22 INFO - 'install', 03:37:22 INFO - 'run-tests'), 03:37:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:37:22 INFO - 'download_minidump_stackwalk': True, 03:37:22 INFO - 'download_symbols': 'ondemand', 03:37:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:37:22 INFO - 'tooltool.py': '/tools/tooltool.py', 03:37:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:37:22 INFO - '/tools/misc-python/virtualenv.py')}, 03:37:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:37:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:37:22 INFO - 'installer_path': 'installer.exe', 03:37:22 INFO - 'log_level': 'info', 03:37:22 INFO - 'log_name': 'talos', 03:37:22 INFO - 'log_to_console': True, 03:37:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:37:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:37:22 INFO - 'opt_config_files': (), 03:37:22 INFO - 'pip_index': False, 03:37:22 INFO - 'sps_profile': False, 03:37:22 INFO - 'sps_profile_interval': 0, 03:37:22 INFO - 'suite': 'dromaeojs-e10s', 03:37:22 INFO - 'system_bits': '32', 03:37:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:37:22 INFO - 'title': 'talos-linux64-ix-045', 03:37:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:37:22 INFO - 'use_talos_json': True, 03:37:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:37:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:37:22 INFO - 'work_dir': 'build'} 03:37:22 INFO - ##### 03:37:22 INFO - ##### Running clobber step. 03:37:22 INFO - ##### 03:37:22 INFO - Running pre-action listener: _resource_record_pre_action 03:37:22 INFO - Running main action method: clobber 03:37:22 INFO - rmtree: /builds/slave/test/build 03:37:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:23 INFO - Running post-action listener: _resource_record_post_action 03:37:23 INFO - ##### 03:37:23 INFO - ##### Running read-buildbot-config step. 03:37:23 INFO - ##### 03:37:23 INFO - Running pre-action listener: _resource_record_pre_action 03:37:23 INFO - Running main action method: read_buildbot_config 03:37:23 INFO - Using buildbot properties: 03:37:23 INFO - { 03:37:23 INFO - "project": "", 03:37:23 INFO - "product": "firefox", 03:37:23 INFO - "script_repo_revision": "production", 03:37:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:37:23 INFO - "repository": "", 03:37:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:37:23 INFO - "buildid": "20160525183450", 03:37:23 INFO - "pgo_build": "True", 03:37:23 INFO - "basedir": "/builds/slave/test", 03:37:23 INFO - "buildnumber": 375, 03:37:23 INFO - "slavename": "talos-linux64-ix-045", 03:37:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:37:23 INFO - "platform": "ubuntu64_hw", 03:37:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:37:23 INFO - "branch": "mozilla-aurora", 03:37:23 INFO - "repo_path": "releases/mozilla-aurora", 03:37:23 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 03:37:23 INFO - "stage_platform": "linux64-pgo", 03:37:23 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 03:37:23 INFO - "slavebuilddir": "test" 03:37:23 INFO - } 03:37:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:37:23 INFO - Running post-action listener: _resource_record_post_action 03:37:23 INFO - ##### 03:37:23 INFO - ##### Running download-and-extract step. 03:37:23 INFO - ##### 03:37:23 INFO - Running pre-action listener: _resource_record_pre_action 03:37:23 INFO - Running main action method: download_and_extract 03:37:23 INFO - mkdir: /builds/slave/test/build/tests 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:23 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:24 INFO - Downloaded 1361 bytes. 03:37:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:24 INFO - Using the following test package requirements: 03:37:24 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:24 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:37:24 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:37:24 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'jsshell-linux-x86_64.zip'], 03:37:24 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:37:24 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:24 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:37:24 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:37:24 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:37:24 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:37:24 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:24 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:37:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:25 INFO - Downloaded 24140640 bytes. 03:37:25 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'] 03:37:25 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 03:37:26 INFO - Return code: 0 03:37:26 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 03:37: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')]} 03:37:26 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:37:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:27 INFO - Downloaded 24140640 bytes. 03:37:27 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'] 03:37:27 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 03:37:29 INFO - Return code: 0 03:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:29 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:29 INFO - Downloaded 10840145 bytes. 03:37:29 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'] 03:37:29 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 03:37:30 INFO - Return code: 0 03:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:30 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:37:31 INFO - Downloaded 62759817 bytes. 03:37:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:31 INFO - mkdir: /builds/slave/test/properties 03:37:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:31 INFO - Contents: 03:37:31 INFO - build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:32 INFO - Running post-action listener: _resource_record_post_action 03:37:32 INFO - Running post-action listener: set_extra_try_arguments 03:37:32 INFO - ##### 03:37:32 INFO - ##### Running populate-webroot step. 03:37:32 INFO - ##### 03:37:32 INFO - Running pre-action listener: _resource_record_pre_action 03:37:32 INFO - Running main action method: populate_webroot 03:37:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:37:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:37:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:37:32 INFO - '--tppagecycles', 03:37:32 INFO - '7'], 03:37:32 INFO - 'tests': ['tsvgm']}}, 03:37:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:37:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:37:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['damp', 'tps']}, 03:37:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'tests': ['damp', 'tps']}, 03:37:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['dromaeo_dom']}, 03:37:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['a11yr', 03:37:32 INFO - 'ts_paint', 03:37:32 INFO - 'tpaint', 03:37:32 INFO - 'sessionrestore', 03:37:32 INFO - 'sessionrestore_no_auto_restore', 03:37:32 INFO - 'tabpaint']}, 03:37:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:32 INFO - 'ts_paint', 03:37:32 INFO - 'tpaint', 03:37:32 INFO - 'sessionrestore', 03:37:32 INFO - 'sessionrestore_no_auto_restore', 03:37:32 INFO - 'tabpaint']}, 03:37:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:37:32 INFO - 'ts_paint', 03:37:32 INFO - 'tpaint', 03:37:32 INFO - 'sessionrestore', 03:37:32 INFO - 'sessionrestore_no_auto_restore', 03:37:32 INFO - 'tabpaint']}, 03:37:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:37:32 INFO - 'ts_paint', 03:37:32 INFO - 'tpaint', 03:37:32 INFO - 'sessionrestore', 03:37:32 INFO - 'sessionrestore_no_auto_restore', 03:37:32 INFO - 'tabpaint']}, 03:37:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['a11yr', 03:37:32 INFO - 'ts_paint', 03:37:32 INFO - 'tpaint', 03:37:32 INFO - 'sessionrestore', 03:37:32 INFO - 'sessionrestore_no_auto_restore', 03:37:32 INFO - 'tabpaint']}, 03:37:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['a11yr', 03:37:32 INFO - 'ts_paint', 03:37:32 INFO - 'tpaint', 03:37:32 INFO - 'sessionrestore', 03:37:32 INFO - 'sessionrestore_no_auto_restore', 03:37:32 INFO - 'tabpaint']}, 03:37:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['tsvgx', 03:37:32 INFO - 'tsvgr_opacity', 03:37:32 INFO - 'tart', 03:37:32 INFO - 'tscrollx', 03:37:32 INFO - 'cart']}, 03:37:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:32 INFO - 'tsvgr_opacity', 03:37:32 INFO - 'tart', 03:37:32 INFO - 'tscrollx', 03:37:32 INFO - 'cart']}, 03:37:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'talos_options': ['--disable-e10s'], 03:37:32 INFO - 'tests': ['tp5o']}, 03:37:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'tests': ['tp5o']}, 03:37:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'talos_options': ['--disable-e10s', 03:37:32 INFO - '--xperf_path', 03:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:32 INFO - 'tests': ['tp5n']}, 03:37:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:32 INFO - 'talos_options': ['--xperf_path', 03:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:32 INFO - 'tests': ['tp5n']}}, 03:37:32 INFO - 'talos.zip': {'path': '', 03:37:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:37:32 INFO - Running post-action listener: _resource_record_post_action 03:37:32 INFO - ##### 03:37:32 INFO - ##### Running create-virtualenv step. 03:37:32 INFO - ##### 03:37:32 INFO - Running pre-action listener: _resource_record_pre_action 03:37:32 INFO - Running main action method: create_virtualenv 03:37:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:37:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:32 INFO - Using real prefix '/usr' 03:37:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:35 INFO - Installing pip.................done. 03:37:35 INFO - Return code: 0 03:37:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:37:35 INFO - Using env: {'DISPLAY': ':0', 03:37:35 INFO - 'HOME': '/home/cltbld', 03:37:35 INFO - 'LANG': 'en_US.UTF-8', 03:37:35 INFO - 'LANGUAGE': 'en_US:en', 03:37:35 INFO - 'LOGNAME': 'cltbld', 03:37:35 INFO - 'MAIL': '/var/mail/cltbld', 03:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:35 INFO - 'MOZ_NO_REMOTE': '1', 03:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:35 INFO - 'NO_EM_RESTART': '1', 03:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:35 INFO - 'PWD': '/builds/slave/test', 03:37:35 INFO - 'SHELL': '/bin/bash', 03:37:35 INFO - 'SHLVL': '1', 03:37:35 INFO - 'TERM': 'linux', 03:37:35 INFO - 'TMOUT': '86400', 03:37:35 INFO - 'USER': 'cltbld', 03:37:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:35 INFO - '_': '/tools/buildbot/bin/python'} 03:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:37:35 INFO - Cleaning up... 03:37:35 INFO - Return code: 0 03:37:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:37:35 INFO - Using env: {'DISPLAY': ':0', 03:37:35 INFO - 'HOME': '/home/cltbld', 03:37:35 INFO - 'LANG': 'en_US.UTF-8', 03:37:35 INFO - 'LANGUAGE': 'en_US:en', 03:37:35 INFO - 'LOGNAME': 'cltbld', 03:37:35 INFO - 'MAIL': '/var/mail/cltbld', 03:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:35 INFO - 'MOZ_NO_REMOTE': '1', 03:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:35 INFO - 'NO_EM_RESTART': '1', 03:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:35 INFO - 'PWD': '/builds/slave/test', 03:37:35 INFO - 'SHELL': '/bin/bash', 03:37:35 INFO - 'SHLVL': '1', 03:37:35 INFO - 'TERM': 'linux', 03:37:35 INFO - 'TMOUT': '86400', 03:37:35 INFO - 'USER': 'cltbld', 03:37:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:35 INFO - '_': '/tools/buildbot/bin/python'} 03:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:35 INFO - Downloading/unpacking psutil>=0.7.1 03:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:37 INFO - Installing collected packages: psutil 03:37:37 INFO - Running setup.py install for psutil 03:37:37 INFO - building 'psutil._psutil_linux' extension 03:37:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:37:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:37:37 INFO - building 'psutil._psutil_posix' extension 03:37:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:37:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:37 INFO - Successfully installed psutil 03:37:37 INFO - Cleaning up... 03:37:38 INFO - Return code: 0 03:37:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:38 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 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:38 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 03:37:38 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 03:37:38 INFO - Using env: {'DISPLAY': ':0', 03:37:38 INFO - 'HOME': '/home/cltbld', 03:37:38 INFO - 'LANG': 'en_US.UTF-8', 03:37:38 INFO - 'LANGUAGE': 'en_US:en', 03:37:38 INFO - 'LOGNAME': 'cltbld', 03:37:38 INFO - 'MAIL': '/var/mail/cltbld', 03:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:38 INFO - 'MOZ_NO_REMOTE': '1', 03:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:38 INFO - 'NO_EM_RESTART': '1', 03:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:38 INFO - 'PWD': '/builds/slave/test', 03:37:38 INFO - 'SHELL': '/bin/bash', 03:37:38 INFO - 'SHLVL': '1', 03:37:38 INFO - 'TERM': 'linux', 03:37:38 INFO - 'TMOUT': '86400', 03:37:38 INFO - 'USER': 'cltbld', 03:37:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:38 INFO - '_': '/tools/buildbot/bin/python'} 03:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:37:40 INFO - Installing collected packages: mozsystemmonitor 03:37:40 INFO - Running setup.py install for mozsystemmonitor 03:37:40 INFO - Successfully installed mozsystemmonitor 03:37:40 INFO - Cleaning up... 03:37:40 INFO - Return code: 0 03:37:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:37:40 INFO - Using env: {'DISPLAY': ':0', 03:37:40 INFO - 'HOME': '/home/cltbld', 03:37:40 INFO - 'LANG': 'en_US.UTF-8', 03:37:40 INFO - 'LANGUAGE': 'en_US:en', 03:37:40 INFO - 'LOGNAME': 'cltbld', 03:37:40 INFO - 'MAIL': '/var/mail/cltbld', 03:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:40 INFO - 'MOZ_NO_REMOTE': '1', 03:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:40 INFO - 'NO_EM_RESTART': '1', 03:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:40 INFO - 'PWD': '/builds/slave/test', 03:37:40 INFO - 'SHELL': '/bin/bash', 03:37:40 INFO - 'SHLVL': '1', 03:37:40 INFO - 'TERM': 'linux', 03:37:40 INFO - 'TMOUT': '86400', 03:37:40 INFO - 'USER': 'cltbld', 03:37:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:40 INFO - '_': '/tools/buildbot/bin/python'} 03:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:43 INFO - Downloading docopt-0.6.1.tar.gz 03:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:43 INFO - Running setup.py install for blobuploader 03:37:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:43 INFO - Running setup.py install for requests 03:37:43 INFO - Running setup.py install for docopt 03:37:43 INFO - Successfully installed blobuploader requests docopt 03:37:43 INFO - Cleaning up... 03:37:43 INFO - Return code: 0 03:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:43 INFO - Using env: {'DISPLAY': ':0', 03:37:43 INFO - 'HOME': '/home/cltbld', 03:37:43 INFO - 'LANG': 'en_US.UTF-8', 03:37:43 INFO - 'LANGUAGE': 'en_US:en', 03:37:43 INFO - 'LOGNAME': 'cltbld', 03:37:43 INFO - 'MAIL': '/var/mail/cltbld', 03:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:43 INFO - 'MOZ_NO_REMOTE': '1', 03:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:43 INFO - 'NO_EM_RESTART': '1', 03:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:43 INFO - 'PWD': '/builds/slave/test', 03:37:43 INFO - 'SHELL': '/bin/bash', 03:37:43 INFO - 'SHLVL': '1', 03:37:43 INFO - 'TERM': 'linux', 03:37:43 INFO - 'TMOUT': '86400', 03:37:43 INFO - 'USER': 'cltbld', 03:37:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:43 INFO - '_': '/tools/buildbot/bin/python'} 03:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:43 INFO - Running setup.py (path:/tmp/pip-AMKfCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:44 INFO - Running setup.py (path:/tmp/pip-9eaeU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:44 INFO - Running setup.py (path:/tmp/pip-2y0NLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:44 INFO - Running setup.py (path:/tmp/pip-3U94h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:44 INFO - Running setup.py (path:/tmp/pip-RGkYtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:44 INFO - Running setup.py (path:/tmp/pip-G916CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:44 INFO - Running setup.py (path:/tmp/pip-Q0SH3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:44 INFO - Running setup.py (path:/tmp/pip-g0d9bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:44 INFO - Running setup.py (path:/tmp/pip-ke83Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:44 INFO - Running setup.py (path:/tmp/pip-kkfvCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:44 INFO - Running setup.py (path:/tmp/pip-BjG2b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:44 INFO - Running setup.py (path:/tmp/pip-qnmDyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:44 INFO - Running setup.py (path:/tmp/pip-7WLYJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:44 INFO - Running setup.py (path:/tmp/pip-RcuaZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:44 INFO - Running setup.py (path:/tmp/pip-xqsSoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:45 INFO - Running setup.py (path:/tmp/pip-zZlToI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:45 INFO - Running setup.py (path:/tmp/pip-h3J_mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:45 INFO - Running setup.py install for manifestparser 03:37:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Running setup.py install for mozcrash 03:37:45 INFO - Running setup.py install for mozdebug 03:37:45 INFO - Running setup.py install for mozdevice 03:37:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Running setup.py install for mozfile 03:37:45 INFO - Running setup.py install for mozhttpd 03:37:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Running setup.py install for mozinfo 03:37:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Running setup.py install for mozInstall 03:37:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Running setup.py install for mozleak 03:37:46 INFO - Running setup.py install for mozlog 03:37:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:46 INFO - Running setup.py install for moznetwork 03:37:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:46 INFO - Running setup.py install for mozprocess 03:37:46 INFO - Running setup.py install for mozprofile 03:37:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:46 INFO - Running setup.py install for mozrunner 03:37:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:46 INFO - Running setup.py install for mozscreenshot 03:37:46 INFO - Running setup.py install for moztest 03:37:46 INFO - Running setup.py install for mozversion 03:37:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:46 INFO - Cleaning up... 03:37:46 INFO - Return code: 0 03:37:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:46 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 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:46 INFO - Using env: {'DISPLAY': ':0', 03:37:46 INFO - 'HOME': '/home/cltbld', 03:37:46 INFO - 'LANG': 'en_US.UTF-8', 03:37:46 INFO - 'LANGUAGE': 'en_US:en', 03:37:46 INFO - 'LOGNAME': 'cltbld', 03:37:46 INFO - 'MAIL': '/var/mail/cltbld', 03:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:46 INFO - 'MOZ_NO_REMOTE': '1', 03:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:46 INFO - 'NO_EM_RESTART': '1', 03:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:46 INFO - 'PWD': '/builds/slave/test', 03:37:46 INFO - 'SHELL': '/bin/bash', 03:37:46 INFO - 'SHLVL': '1', 03:37:46 INFO - 'TERM': 'linux', 03:37:46 INFO - 'TMOUT': '86400', 03:37:46 INFO - 'USER': 'cltbld', 03:37:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:46 INFO - '_': '/tools/buildbot/bin/python'} 03:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:47 INFO - Running setup.py (path:/tmp/pip-NFBXs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:47 INFO - Running setup.py (path:/tmp/pip-Y2uKUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:47 INFO - Running setup.py (path:/tmp/pip-vjF5g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:47 INFO - Running setup.py (path:/tmp/pip-K3gUzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:47 INFO - Running setup.py (path:/tmp/pip-IamgrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:47 INFO - Running setup.py (path:/tmp/pip-MKFx81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:47 INFO - Running setup.py (path:/tmp/pip-W_Z_YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:47 INFO - Running setup.py (path:/tmp/pip-aXtNYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:47 INFO - Running setup.py (path:/tmp/pip-r6G93g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:47 INFO - Running setup.py (path:/tmp/pip-_cs49Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:47 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)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:47 INFO - Running setup.py (path:/tmp/pip-_hXosN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:47 INFO - Running setup.py (path:/tmp/pip-lHigji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:48 INFO - Running setup.py (path:/tmp/pip-wvSFLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:48 INFO - Running setup.py (path:/tmp/pip-PKp_uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:48 INFO - Running setup.py (path:/tmp/pip-16J8on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:48 INFO - Running setup.py (path:/tmp/pip-HOC52Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:48 INFO - Running setup.py (path:/tmp/pip-0I6TuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:50 INFO - Downloading blessings-1.6.tar.gz 03:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:50 INFO - Installing collected packages: blessings 03:37:50 INFO - Running setup.py install for blessings 03:37:50 INFO - Successfully installed blessings 03:37:50 INFO - Cleaning up... 03:37:50 INFO - Return code: 0 03:37:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:50 INFO - Reading from file tmpfile_stdout 03:37:50 INFO - Current package versions: 03:37:50 INFO - argparse == 1.2.1 03:37:50 INFO - blessings == 1.6 03:37:50 INFO - blobuploader == 1.2.4 03:37:50 INFO - docopt == 0.6.1 03:37:50 INFO - manifestparser == 1.1 03:37:50 INFO - mozInstall == 1.12 03:37:50 INFO - mozcrash == 0.17 03:37:50 INFO - mozdebug == 0.1 03:37:50 INFO - mozdevice == 0.48 03:37:50 INFO - mozfile == 1.2 03:37:50 INFO - mozhttpd == 0.7 03:37:50 INFO - mozinfo == 0.9 03:37:50 INFO - mozleak == 0.1 03:37:50 INFO - mozlog == 3.1 03:37:50 INFO - moznetwork == 0.27 03:37:50 INFO - mozprocess == 0.22 03:37:50 INFO - mozprofile == 0.28 03:37:50 INFO - mozrunner == 6.11 03:37:50 INFO - mozscreenshot == 0.1 03:37:50 INFO - mozsystemmonitor == 0.0 03:37:50 INFO - moztest == 0.7 03:37:50 INFO - mozversion == 1.4 03:37:50 INFO - psutil == 3.1.1 03:37:50 INFO - requests == 1.2.3 03:37:50 INFO - wsgiref == 0.1.2 03:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:50 INFO - Using env: {'DISPLAY': ':0', 03:37:50 INFO - 'HOME': '/home/cltbld', 03:37:50 INFO - 'LANG': 'en_US.UTF-8', 03:37:50 INFO - 'LANGUAGE': 'en_US:en', 03:37:50 INFO - 'LOGNAME': 'cltbld', 03:37:50 INFO - 'MAIL': '/var/mail/cltbld', 03:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:50 INFO - 'MOZ_NO_REMOTE': '1', 03:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:50 INFO - 'NO_EM_RESTART': '1', 03:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:50 INFO - 'PWD': '/builds/slave/test', 03:37:50 INFO - 'SHELL': '/bin/bash', 03:37:50 INFO - 'SHLVL': '1', 03:37:50 INFO - 'TERM': 'linux', 03:37:50 INFO - 'TMOUT': '86400', 03:37:50 INFO - 'USER': 'cltbld', 03:37:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:50 INFO - '_': '/tools/buildbot/bin/python'} 03:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:37:51 INFO - Cleaning up... 03:37:51 INFO - Return code: 0 03:37:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:37:51 INFO - Using env: {'DISPLAY': ':0', 03:37:51 INFO - 'HOME': '/home/cltbld', 03:37:51 INFO - 'LANG': 'en_US.UTF-8', 03:37:51 INFO - 'LANGUAGE': 'en_US:en', 03:37:51 INFO - 'LOGNAME': 'cltbld', 03:37:51 INFO - 'MAIL': '/var/mail/cltbld', 03:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:51 INFO - 'MOZ_NO_REMOTE': '1', 03:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:51 INFO - 'NO_EM_RESTART': '1', 03:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:51 INFO - 'PWD': '/builds/slave/test', 03:37:51 INFO - 'SHELL': '/bin/bash', 03:37:51 INFO - 'SHLVL': '1', 03:37:51 INFO - 'TERM': 'linux', 03:37:51 INFO - 'TMOUT': '86400', 03:37:51 INFO - 'USER': 'cltbld', 03:37:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:51 INFO - '_': '/tools/buildbot/bin/python'} 03:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:51 INFO - Downloading/unpacking jsonschema 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:53 INFO - Downloading/unpacking functools32 (from jsonschema) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:53 INFO - warning: no files found matching '*.txt' 03:37:53 INFO - no previously-included directories found matching 'build' 03:37:53 INFO - no previously-included directories found matching 'dist' 03:37:53 INFO - no previously-included directories found matching '.git*' 03:37:53 INFO - Installing collected packages: jsonschema, functools32 03:37:53 INFO - Running setup.py install for functools32 03:37:53 INFO - warning: no files found matching '*.txt' 03:37:53 INFO - no previously-included directories found matching 'build' 03:37:53 INFO - no previously-included directories found matching 'dist' 03:37:53 INFO - no previously-included directories found matching '.git*' 03:37:53 INFO - Successfully installed jsonschema functools32 03:37:53 INFO - Cleaning up... 03:37:53 INFO - Return code: 0 03:37:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b7247f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, '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': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:37: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', 'flake8'] in /builds/slave/test/build 03:37: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 flake8 03:37:53 INFO - Using env: {'DISPLAY': ':0', 03:37:53 INFO - 'HOME': '/home/cltbld', 03:37:53 INFO - 'LANG': 'en_US.UTF-8', 03:37:53 INFO - 'LANGUAGE': 'en_US:en', 03:37:53 INFO - 'LOGNAME': 'cltbld', 03:37:53 INFO - 'MAIL': '/var/mail/cltbld', 03:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:53 INFO - 'MOZ_NO_REMOTE': '1', 03:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:53 INFO - 'NO_EM_RESTART': '1', 03:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:53 INFO - 'PWD': '/builds/slave/test', 03:37:53 INFO - 'SHELL': '/bin/bash', 03:37:53 INFO - 'SHLVL': '1', 03:37:53 INFO - 'TERM': 'linux', 03:37:53 INFO - 'TMOUT': '86400', 03:37:53 INFO - 'USER': 'cltbld', 03:37:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:53 INFO - '_': '/tools/buildbot/bin/python'} 03:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:53 INFO - Downloading/unpacking flake8 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:37:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:37:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:56 INFO - no previously-included directories found matching 'docs/_build' 03:37:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:37:56 INFO - Running setup.py install for pep8 03:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:56 INFO - no previously-included directories found matching 'docs/_build' 03:37:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:37:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:37:56 INFO - Cleaning up... 03:37:56 INFO - Return code: 0 03:37:56 INFO - Running post-action listener: _resource_record_post_action 03:37:56 INFO - Running post-action listener: _start_resource_monitoring 03:37:56 INFO - Starting resource monitoring. 03:37:56 INFO - ##### 03:37:56 INFO - ##### Running install step. 03:37:56 INFO - ##### 03:37:56 INFO - Running pre-action listener: _resource_record_pre_action 03:37:56 INFO - Running main action method: install 03:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:56 INFO - Reading from file tmpfile_stdout 03:37:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:56 INFO - Reading from file tmpfile_stdout 03:37:56 INFO - Output received: 03:37:56 INFO - Usage: mozinstall [options] installer 03:37:56 INFO - Options: 03:37:56 INFO - -h, --help show this help message and exit 03:37:56 INFO - -d DEST, --destination=DEST 03:37:56 INFO - Directory to install application into. [default: 03:37:56 INFO - "/builds/slave/test"] 03:37:56 INFO - --app=APP Application being installed. [default: firefox] 03:37:56 INFO - mkdir: /builds/slave/test/build/application 03:37:56 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'] 03:37:56 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 03:38:12 INFO - Reading from file tmpfile_stdout 03:38:12 INFO - Output received: 03:38:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:38:12 INFO - Running post-action listener: _resource_record_post_action 03:38:12 INFO - ##### 03:38:12 INFO - ##### Running run-tests step. 03:38:12 INFO - ##### 03:38:12 INFO - Running pre-action listener: _resource_record_pre_action 03:38:12 INFO - Running main action method: run_tests 03:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:12 INFO - Python 2.7.3 03:38:12 INFO - Return code: 0 03:38:12 INFO - grabbing minidump binary from tooltool 03:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:12 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 0x29ad410>, '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 0x29ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ae7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:38:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:38:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:12 INFO - Return code: 0 03:38:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:38:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:38:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:38:13 INFO - Return code: 0 03:38:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:38:13 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:38:13 INFO - Using env: {'DISPLAY': ':0', 03:38:13 INFO - 'HOME': '/home/cltbld', 03:38:13 INFO - 'LANG': 'en_US.UTF-8', 03:38:13 INFO - 'LANGUAGE': 'en_US:en', 03:38:13 INFO - 'LOGNAME': 'cltbld', 03:38:13 INFO - 'MAIL': '/var/mail/cltbld', 03:38:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:13 INFO - 'MOZ_NO_REMOTE': '1', 03:38:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:13 INFO - 'NO_EM_RESTART': '1', 03:38:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:13 INFO - 'PWD': '/builds/slave/test', 03:38:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:13 INFO - 'SHELL': '/bin/bash', 03:38:13 INFO - 'SHLVL': '1', 03:38:13 INFO - 'TERM': 'linux', 03:38:13 INFO - 'TMOUT': '86400', 03:38:13 INFO - 'USER': 'cltbld', 03:38:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464431840.391827-1565704662', 03:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:13 INFO - '_': '/tools/buildbot/bin/python'} 03:38:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:38:13 INFO - mozversion application_buildid: 20160525183450 03:38:13 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:38:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:13 INFO - mozversion application_name: Firefox 03:38:13 INFO - mozversion application_remotingname: firefox-dev 03:38:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:13 INFO - mozversion application_vendor: Mozilla 03:38:13 INFO - mozversion application_version: 48.0a2 03:38:13 INFO - mozversion platform_buildid: 20160525183450 03:38:13 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:13 INFO - mozversion platform_version: 48.0a2 03:38:13 INFO - using testdate: 1464431893 03:38:13 INFO - actual date: 1464431893 03:38:13 INFO - starting webserver on 'localhost:46237' 03:38:13 INFO - SUITE-START | Running 2 tests 03:38:13 INFO - TEST-START | dromaeo_css 03:38:13 INFO - operating with platform_type : linux_ 03:38:13 INFO - Initialising browser for dromaeo_css test... 03:38:13 INFO - TEST-INFO | started process 32437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XlHug/profile http://localhost:46237/getInfo.html) 03:38:17 INFO - PROCESS | 32437 | 03:38:17 INFO - PROCESS | 32437 | (process:32518): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:18 INFO - PROCESS | 32437 | __metrics Screen width/height:1600/1200 03:38:18 INFO - PROCESS | 32437 | colorDepth:24 03:38:18 INFO - PROCESS | 32437 | Browser inner width/height: 1024/697 03:38:18 INFO - PROCESS | 32437 | __metrics 03:38:19 ERROR - PROCESS | 32437 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:38:19 INFO - TEST-INFO | 32437: exit 0 03:38:19 INFO - Browser initialized. 03:38:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:19 INFO - TEST-INFO | started process 32569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XlHug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:21 INFO - PROCESS | 32569 | 03:38:21 INFO - PROCESS | 32569 | (process:32637): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:31 INFO - PROCESS | 32569 | RSS: Main: 151506944 03:38:31 INFO - PROCESS | 32569 | 03:39:21 INFO - PROCESS | 32569 | 1464431961384 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:41:28 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:46237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46237/tests/dromaeo/cssquery-ext.html) 03:41:29 INFO - PROCESS | 32569 | RSS: Main: 154972160 03:41:29 INFO - PROCESS | 32569 | 03:44:31 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:46237/tests/dromaeo/cssquery-ext.html (next: http://localhost:46237/tests/dromaeo/cssquery-jquery.html) 03:44:32 INFO - PROCESS | 32569 | RSS: Main: 153288704 03:44:32 INFO - PROCESS | 32569 | 03:47:34 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:46237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46237/tests/dromaeo/cssquery-mootools.html) 03:47:34 INFO - PROCESS | 32569 | RSS: Main: 153096192 03:47:34 INFO - PROCESS | 32569 | 03:50:36 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:46237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46237/tests/dromaeo/cssquery-prototype.html) 03:50:36 INFO - PROCESS | 32569 | RSS: Main: 152891392 03:50:36 INFO - PROCESS | 32569 | 03:53:39 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:46237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46237/tests/dromaeo/cssquery-yui.html) 03:53:39 INFO - PROCESS | 32569 | RSS: Main: 154214400 03:53:39 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:46237/tests/dromaeo/cssquery-yui.html (next: http://localhost:46237/tests/dromaeo/cssquery-dojo.html) 03:56:42 INFO - PROCESS | 32569 | RSS: Main: 155607040 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | __start_tp_report 03:56:42 INFO - PROCESS | 32569 | _x_x_mozilla_page_load 03:56:42 INFO - PROCESS | 32569 | _x_x_mozilla_page_load_details 03:56:42 INFO - PROCESS | 32569 | |i|pagename|runs| 03:56:42 INFO - PROCESS | 32569 | |0;dojo.html;3379.9860041987404;3393.609734880488;3441.741869359797;3462.047936817375;3474.913127171819;5721.713914304284;5737.713114344282;5775.682337471438;5801.622894511854;5805.535557155428;5730.083186690131;5798.565107616935;5800.274965629296;5822.9417705822925;5828.154917536955;5236.21456781483;5251.711155886424;5296.602754793406;5323.467653234684;5331.840044798662;5110.463401342861;5216.76524556394;5219.086659834514;5403.540699040586;5409.513143817056;5079.161938280179;5166.664166829163;5182.974085129569;5198.090334191501;5249.8950020999555;5218.1650935850275;5220.008198442303;5226.634135610509;5230.267762513251;5261.86845328866;5015.398152221756;5071.670341427833;5133.563647090002;5180.663256888328;5203.453637368098;5613.971930140364;5671.347795003545;5695.971520142414;5710.571707121982;5752.108423194411;6078.8784224315705;6129.019356902919;6140.785072522441;6141.600795948294;6146.231721034871;6104.633721976651;6187.81436556904;6198.008318669036;6214.65819379934;6218.22272215973;5798.217240672539;5803.042497987827;5815.273090863642;5815.854603634901;5841.357450680422;6345.17512723343;6345.238571371373;6359.427651511386;6387.010013447923;6402.839929001812;5764.481196692234;6018.127371531104;6092.786752463642;6111.786087486917;6125.693715314216;6061.151438798572;6079.604825686316;6081;6088.939110608837;6136.723847426876;6029.788957386558;6056.182415373868;6064.878702425926;6065.75736970525;6070.6357618543025;5987.042073268256;6102.267727872683;6121.6358891611635;6142.345304543789;6192.8761424771255;4690.929636055462;4697.412823397075;4701.2242979908615;4712.552307530779;4715.976420117878;4174.791260436966;4194.203101410783;4196.748195108304;4198.055437526593;4235.576442355739;5766.04860198071;5963.880722385528;6007.339192688801;6015.3383127855905;6040.728167232485;6097.878042439126;6138.600990935575;6140.846478837975;6159.414855588801;6165.0444181152;5739.71301434935;5863.384344643836;5870.207521984563;5878.941210587925;5898.8820223595285;5300.496452836975;5311.575073994071;5326.414094449608;5350.3312085989255;5356.758945847446;6408.327125651833;6408.67956602168;6420.903686444707;6431.196100487439;6449.226092868886;5930.495907847881;6178.258608966953;6209.96895015522;6230.470410015199;6234.906476402857;6217.658028808459;6259.749610015549;6267.435930766253;6276.089966954674;6285.308616052139;5938.673372964528;5967.254093238345;5976.7908123215475;5987.790427335022;6043.486303664238;6009.36901625323;6082.635041897501;6092.543059270661;6094.512439004958;6130;5976.641401515923;6001.5798894077;6006.969965150146;6008.7296071676;6014.939850601438;5910.113482977587;5963.403659634002;5970.552208584287;5974.761009559569;5992.550558708202;5743.052396354555;5797.942020579909;5925.911111333247;5963.940360596339;5985.581009329305;6030.5778595497895;6056.3035250946705;6078.422549857756;6094.238220222473;6094.268687757498;5929.6145750526075;5952.136940143741;5952.226210592596;5960.672163031075;5963.493103086286 03:56:42 INFO - PROCESS | 32569 | |1;ext.html;602.8944934636437;662.6421732264578;664.5447868210273;672.4116398151618;720.2437440687277;40355.19289614209;40691.18617627646;41017;41057.58942410579;41080.58919410805;42203;42857.7857110714;42942.35586466198;43012.56987430125;43056;8868.733937981855;9093.772655683595;9098.818023639524;9108.499032553207;9172.449653020807;8911.866322005142;9055.547222638874;9094.909050909473;9346.906530934672;9355.345125841193;9335.76660583484;9337.486438245927;9349.719508414724;9388.718338449857;9430.622775089023;9246.306527010467;9272.443653380818;9362.531873406302;9368.718938431857;9370.250379969586;9197.080291970817;9282.675106371245;9333;9334.486603236819;9334.766630834216;44631;45069.54930450719;45314.093718125456;45407;45419.77290113561;3673.6510031547227;3809.771413715186;3823.5220597425323;3920.764754114734;4187.198229447343;35243.1189220269;35314.29371412583;35464.645353546395;35518;35601.82199089014;4503.504614492404;4544.068465964469;4572.359869618256;4575.862724118282;4615.46922103959;287332;288846.5557672219;289650;290443;291536;58860.411395885494;59236.40763592309;59260;59285.70357148186;59581.702091489264;66478.66760666166;72849.6357518209;74467;74547.62726186334;74975.25024749682;18649.533761655795;18837.811621883604;18931.62136757257;19006.52483687891;19037.61924761497;14468;14555.490557830424;14574.271286435636;14577.344019519147;14654.120752754869;21038.579228415347;21266.36200913975;21311.573768524853;21311.68032479514;21349.35951921445;7498.3626391756225;7538.773836784905;7586.317231449196;7644;7758.883616745753;1155.6186458468685;1169.2049406403728;1175.5767923547517;1177.0054304113012;1248.731522722619;34586.30827383438;34958.30083398369;35860.46209306862;35933.64066359303;35942.8202858984;1191.74377508836;1246.407956220806;1247.4137155536882;1266.9927407710893;1327.462377737018;16066.518004459651;16143.273552690158;16422.343106275614;16481.752773708406;16655.25051372691;491127;538827;557724;567331;567857;58844.41155588475;59342.703286483295;59495;59501.70249148727;59990;1522.1704171226709;1524.2683511914122;1535.6544777425213;1554.5258696097799;1600.1039417926;31906;32646;32698.673013270516;32736.50895236621;32884.94136539883;57246;57309;58061.70969145127;58089.709551451975;58168.4183158163;321598;322399;325142;326635;326900;31560.684393156695;31809.363812723153;32068.19829504281;32235;32673.34653306968;52143.47856521386;52615.21077183922;53311;53699.73150134224;53865.192022118914;38499.2300154001;38721;43003.56996429995;43280.350794737475;43348.783256083516;40997.38503922503;41285.38071928863;41717.165656687306;42325;42999.355009674255;41140.794296028325;43235.13529729451;44018.559814402724;44547.777261113486;45057;35843;35849.46225806563;36111.27777444489;36238.45642315315;37081.629183708894;28808.423831522832;29300.267493312836;29376.853115734284;29574.112776616737;29574.556381653863 03:56:42 INFO - PROCESS | 32569 | |2;jquery.html;423.5150752388515;430.18909355864184;432.74251820167;433.2980571474212;442.63261492960845;18708.15813288402;19311.613767724655;19366.41900742978;19464.610707785836;20152.093155807986;12037.458314375852;12174.269543827377;12194.268343899372;17808.842425242383;18295.54261143469;5176.689398636075;5293.15309550472;5298.125809241471;5298.523132918037;5301.973490132544;5388.973055134738;5673.801416950408;5777.0756678931375;5803.6227645203135;5810.215620891189;5843.883122337572;5855.355910849803;5857.619254748449;5862.179294898718;5863.5016023638045;5446.891062178754;5760.049591817345;5764.942350576483;5782.537397008229;5800.419958004187;5158.561522270612;5207.609429292818;5214.765335559909;5232.581393488512;5236.973815130938;14271.714565708731;14287.928560357132;14301.570952871327;14374.568762937128;16573.917130414393;2423.587990041697;2455.3493324269084;2467.395488105408;2709.512287788197;2875.2236896037953;10053.597856085747;10141.54363053657;10384.065434110966;10518.158547316196;10556.736081597945;2038.8776673399643;2049.6720524716125;2094.979050209509;2101.495641046153;2138.7754285799924;80106.59946700287;82713.58643206806;83343;84152.57923710403;84507.92952422936;10441.32131411471;10734.35593864355;10791.784164316827;11042;11297.209195356247;15105.3202605883;15164.469243576423;15170.24148792578;15188.088714677155;15197;8142.4300298978505;8423.747287581382;8483.194096560817;8499.150084991576;8534.402591818638;8405.831883362422;8478.74563763088;8602.61288242018;8632;8645.91354086451;4716.740579268105;4759.690620109682;4766.993588079045;4773.689710168828;4810.979388656702;1976.733141025972;1984.7419835421304;2024.2409096588779;2069.172331067585;2099.601075795594;1041.6510468992822;1081.691717860406;1090.5092708281147;1117.2961034548182;1125.1448898836943;18181.45455636333;18643.627127457374;18885.716714249298;18913.14890829916;19699.704504432444;1073.4632683658172;1092.6448904106198;1134.704976706046;1160.1994623709613;1162.1632424654235;10680.78638427227;10798.67603971882;10818.783624327469;10852.511636976355;11064.059554937921;468398;469025;469721;470981;525357.6979793555;96590.51704741572;97513;98679.50660246653;100099.49950250202;100904.49547752214;1073.9946300268448;1111.3165403277087;1156.4102307822902;1157.583270022791;1159.4608507044265;16715.665686685956;16968.321267149175;17141.742873856652;17186.398476053277;17326.653466930842;39342.40986385264;39897.2020559593;39947.2010559793;40208.798956005034;41327.38008929929;55569.72215138898;56671.433285666615;56719.14921276102;60772.39227607667;64151.35848641454;9128.908710912805;9182.449053056838;9213.76965575866;9278.11857873501;9289.34974551775;8750.69372571957;11762.706102328566;12715.93642031784;13682.15290935711;13918.652033699238;11240.606578769704;11626.186166968231;11800.409979501163;12119.212251203644;12148.271103733805;11132.777344452903;11729.35488548104;11925.642230733092;11954.940225298818;12009.699757506132;11307.547698091985;11546.42267886619;11784.646460606196;11938.343391113573;12646.177998430072;8834.249088827522;8943.105689431004;8948.418352807046;9065.501397423204;9228.538573071186;11892.286462812259;12416.937915310365;12522.624321270376;12650.936745316214;12855.742885142432 03:56:42 INFO - PROCESS | 32569 | |3;mootools.html;1503.4286970951036;1511.6674331647037;1687.561234079139;1857.7863545692232;1869.2616416515477;8186.467879587823;8271.627776750045;8372.246497815195;8404.033536143354;8433.40966132371;8361.163883611636;8436.029856566496;8441.451305665127;8460.703875364363;8499.830003399928;2341.648752687102;2358.3043002314357;2363.7636236376397;2369.5497855407502;2372.489914668346;2344.9062037518565;2364.574376612209;2405.9639105413435;2419.9395015124587;2422.6608274841537;2363.7163540375095;2391.8923648435775;2392.270357540949;2413.4569721812627;2426.259990702844;2339.7075365579303;2400.0399840063938;2403.098837935774;2403.771641694036;2413.179518963561;2345.7185137783404;2381.773731495505;2384.511175209078;2389.2235023617395;2398.4603464220586;8372.790680232982;8382.413231073828;8432.662693492253;8432.957835210786;8454.957725211334;5181.1969144782615;5256.737163141827;5262.763175657066;5270.815521456769;5280.392754833205;3209.261869769966;3209.9839500802345;3225.161458020908;3374.156460884779;3390.8135052572097;1069.470612047034;1129.3393364881554;1143.702637314296;1144.416347662698;1148.5578052449866;11388.943055284753;11444.256123351955;11494.885051149466;11512.251703639236;11569.710757231052;4287.871363859089;4293.291606884892;4369.3227549729845;4380.6933514653665;4385.232584297735;9176.082391760903;9316.8602470963;9330.113639204264;9335.06649335061;9365.11031452011;4939.135651261015;4973.204287314013;4983.053219888209;4987.0275296317595;5001.349824522788;4018.814449737276;4637.142128706133;4652.371929789435;4710;4736.73947932867;4017.859374921922;4023.2556976959354;4110.897227569335;4125.97937010313;4141.130362623882;1291.2962435472502;1331.10150648312;1333.133463248896;1333.5599252246736;1338.9062765606313;1067.765091679829;1071.9517621707041;1081.799867024603;1087.5377964365114;1116.3971455414148;5772.826815195551;5796.304443466811;5934.198883150806;6042.184305118841;6120.14317995481;424.2893153967093;437.9956200437955;455.1693159982978;466.2889094131477;468.0802223630582;4066.1867626474823;4187.513432731336;4218.767967761742;4236.76697781625;4280.165367753259;9809.558569864374;10045.347052441568;10049.29654924163;10214.029667181754;10240.743981400376;9960.651377201762;10103.949480252551;10231.7442063949;10242.948785256027;10267.691969240936;7649.464537482434;7665.8850117248285;7704.422168337397;7705.15243323234;7931.484453510619;5660.801871934463;5720.48515633595;5750.5112065474905;5751.166080918159;5910.674912879833;9001.36990410665;9098.226650734498;9146.176844084064;9182;9202.631894724136;9044.276457883485;9259.166674999282;9313.487758173365;9329.020452852625;9500.47747373901;6676.0987266718375;7189.856202875809;7274.672639731119;7499.575080734643;7540.019797426299;7810;7924.960375198087;7935.6032198391;7940.801479963047;7956.92043079585;7076.929230707627;7207.279272072751;7219.891701624585;7238.131424229126;7359.595222262827;7124.857502850017;7168.67740951648;7184;7190;7294.234105418855;6869.381755641816;6955.791326260221;6965.582065076112;6985.057017302599;6990.790276291719;5081.5426611605135;5119.513646203604;5205.687658740488;5274.287971123849;5303.416624171416;5117.948820511747;5148.510891465305;5155.922661160011;5163.044836705221;5318.202269659582 03:56:42 INFO - PROCESS | 32569 | |4;prototype.html;327.6003276003276;332.9250918543328;343.3596342820639;353.6163262859797;358.68256592915264;6618.900716489256;6635.502337324702;6711.127553418055;6716.563423377477;6792.354726300993;6560.606363618174;6647.069410282565;6650.767223147191;6653.900191497131;6699.464042876571;4955.479674634165;4956.950430495685;4966.900661986776;4974.37820272466;4986.027724593706;4992.775325110379;4996.4503904570465;4998.900021999558;5004.899902001957;5010.899782004376;4914.508549145093;4922.310876477278;4926.802927882881;4931.087748766489;4950.801967921278;4746.644001699887;4914.754262286871;4941.728204948727;4955.4548999610015;4963.776630051656;4216.2832318505925;4239.236937351276;4250.829966801324;4256.170046840867;4263.168682106991;6324.367563243685;6392.392722691384;6398.16823812906;6413.070104834819;6437.130987316699;5719.256496655408;5738.426157384228;5776.740046697909;5782.306123265193;5785.450382213683;6950.826229344307;6954.4436445084275;6958.2693817148975;6960.338767817049;6988.405985491239;4595.058013107305;4755.524447555217;4759.071980963713;4764.2615394613895;4779.068081724065;7181.712731490734;7254.383377412873;7289.599072051035;7294.051773269441;7309.451791115687;4830.3237546743485;4860.8298709545;4864.756762161877;4865.051314993542;4875.926861097087;4915.0415668944215;4915.336429582032;4919.458859525449;4929.605631549467;4933.506649335038;5743.712814359265;5753.827385178452;5755.8561035974435;5769.826905192851;5770.769169233184;6760.459163266927;7034.155901291878;7035.718571257093;7036.612986285803;7082.150141982995;1710.435556266429;1720.7332863406193;1723.6983527882571;1733.4626265857623;1734.1849330814498;1103.189155970361;1115.041064684371;1127.8984891359817;1133.0538999935147;1141.5547936304847;6582.670866456658;6726.596404215763;6797.728090876409;6813.863722725617;6910.896336554955;7210.206877243499;7219.205887352387;7270.781876543712;7316.561006339637;7352;6814.965925170342;6855.451563874878;6886.552374095668;6899.48253880961;6899.655017249117;3933.449317095609;3960.2277555876326;3961.980190099031;3962.5244970603712;3967.0677390813134;7266.091738532684;7509.812254693677;7513.173550909396;7513.924860751432;7518.699252029857;7435.591042492715;7447.702091916262;7453.664585093684;7458.179600243969;7479.439042071866;7552.207018263003;7559.395248380117;7566.432517561205;7598.518288933605;7616.581088040211;7168.677409516688;7283.781486555412;7294.817629559304;7350.19147893742;7350.669219885011;7138.14342278909;7247.818804529929;7262.237465066092;7263.891041634274;7268.745593904188;7467.58928258951;7522.285382888617;7538.623068846646;7554.093508778982;7575;5002.474740152232;5051.797928082836;5053.494650534917;5053.823116190915;5059.266406371129;7034.402075823612;7264.40183159704;7277.2722727726805;7282.271772822887;7285.052943117361;7104.325089116525;7120.1099862517185;7125.572465652078;7144.571325720473;7146.142462904277;7065.0815393998455;7081.858362832818;7089.751858684921;7091.1490621125795;7092.468064895051;6975.686094125675;6977.651117444209;6978.825529361807;6982.266861979419;6996.440284777307;6937.791866244021;7096.219415864354;7105;7156;7175.354218120394;6785.287544807724;6951.582905025714;6970.442364610718;6997.160340759141;7051.823704407431 03:56:42 INFO - PROCESS | 32569 | |5;yui.html;814.6212011414693;906.9705883821861;912.3066469483191;917.7155081924603;923.6259314977432;14220.857791422082;14385.064970776892;14402.279886005697;14405.92797036016;14422.206778627184;14110.788338174936;14143.292835358243;14172.078814877026;14178.149311041345;14186.929065354685;861.4745005546628;897.1970086772335;923.1322556796623;923.4367036107968;925.3707478914336;910.026271889079;912.3886995712888;916.8487199612056;918.2149262380668;919.4713040001992;949.6723630347519;951.4148798488949;955.9617615295415;957.1337939165066;957.2294303086013;948.1087777489173;948.8481842905137;949.2785483032876;949.4588084791671;949.8765160529156;701.7999870037066;702.0171759536638;702.3398005874461;702.5573888450243;703.8803403421431;14978.775318370124;15019.549413517612;15030.774538381933;15036.924815375962;15061.397544098223;14620;14658.193799341032;14673.486427975076;14759.631009224748;14993;10954.945225273823;11310.886891131066;12542.937285313606;12558.874411255862;12647.43086561107;3959.1883663848844;3974.4435778990673;3984.8804535863683;3987.063040185554;3994.940075898864;54790.45209547893;54994;55105.448945510834;55336.44663553353;56399.43600563983;11134.721631959266;11541.538338466535;11675.649730508097;11847.348395838311;12023.699407514881;20064.498387540138;20073.397798066082;20085.49786255326;20088.598228035356;20106.09522571488;8538.402311838236;8584.828303433897;8652.567371631394;8717.30261579072;8744.69393571222;4853.4418541867435;4946.3817022872145;4957.132501812241;5000.974995125074;5060.240963855377;3431.0736101252523;3459.325431540876;3509.9298014039578;3522.8374636369936;3527.206378564854;658.318640207383;663.1081195791653;664.1001443044605;669.1100835888257;670.4133882852504;680.9625470599066;783.8079670480655;786.9134395216522;799.436397339874;809.6599428240153;9897.752556186153;10176.135028522658;10260.794784104277;10281.640142594973;10452.32059916103;751.7563354861775;753.6307209467321;785.2343964634435;798.7923139983646;806.3871457692196;4579.335996280521;4633.7683115844075;4710.057988402334;4722.574968252874;4783.378160839069;65818.67090664516;66730.66634666892;66742;67083.66458167679;67468.66265668739;54954.175687364725;57824.42175578274;58154;59119.70440147858;59314.70342648259;52919;53230.73384633052;53443.19835202475;53862;54196.45803541914;9123.863142053007;9161.496117713323;9246.167844893991;9248.491332976751;9293.907060929305;39890.60109398869;39899.2020159601;40883.59116408798;41090.9727256809;41175;46321.76839115783;50432;50978;51290.48709512857;51991;11649.941750291195;11915.285082895054;12357.32034738098;12901.225926444444;13119.278439685528;14336.641583960485;14424.350904209545;14852.737517310718;14909.552713418614;15010.174440405446;13075.607731768063;14149.151050936976;14164.575062748134;14407.495737649131;14690.265486725835;12680.74638507243;13294.571531867161;13501;13549.322533873465;13784;12666.176698514568;12792.6801829955;13109.60671179866;13386.19682819034;13418.865811341762;10999.890001099886;11174.72063198394;11377.146713996317;11443.828342575034;11470.082393408675;11275.32348059119;11534.077273818242;11567.248128871597;11626.651200463999;11761.823572646588 03:56:42 INFO - PROCESS | 32569 | __end_tp_report 03:56:42 INFO - PROCESS | 32569 | __start_cc_report 03:56:42 INFO - PROCESS | 32569 | _x_x_mozilla_cycle_collect,328 03:56:42 INFO - PROCESS | 32569 | __end_cc_report 03:56:42 INFO - PROCESS | 32569 | __startTimestamp1464433002328__endTimestamp 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | ------- Summary: start ------- 03:56:42 INFO - PROCESS | 32569 | Number of tests: 6 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | [#0] dojo.html Cycles:165 Average:5712.20 Median:5963.40 stddev:634.39 (10.6%) stddev-sans-first:609.38 03:56:42 INFO - PROCESS | 32569 | Values: 3380.0 3393.6 3441.7 3462.0 3474.9 5721.7 5737.7 5775.7 5801.6 5805.5 5730.1 5798.6 5800.3 5822.9 5828.2 5236.2 5251.7 5296.6 5323.5 5331.8 5110.5 5216.8 5219.1 5403.5 5409.5 5079.2 5166.7 5183.0 5198.1 5249.9 5218.2 5220.0 5226.6 5230.3 5261.9 5015.4 5071.7 5133.6 5180.7 5203.5 5614.0 5671.3 5696.0 5710.6 5752.1 6078.9 6129.0 6140.8 6141.6 6146.2 6104.6 6187.8 6198.0 6214.7 6218.2 5798.2 5803.0 5815.3 5815.9 5841.4 6345.2 6345.2 6359.4 6387.0 6402.8 5764.5 6018.1 6092.8 6111.8 6125.7 6061.2 6079.6 6081.0 6088.9 6136.7 6029.8 6056.2 6064.9 6065.8 6070.6 5987.0 6102.3 6121.6 6142.3 6192.9 4690.9 4697.4 4701.2 4712.6 4716.0 4174.8 4194.2 4196.7 4198.1 4235.6 5766.0 5963.9 6007.3 6015.3 6040.7 6097.9 6138.6 6140.8 6159.4 6165.0 5739.7 5863.4 5870.2 5878.9 5898.9 5300.5 5311.6 5326.4 5350.3 5356.8 6408.3 6408.7 6420.9 6431.2 6449.2 5930.5 6178.3 6210.0 6230.5 6234.9 6217.7 6259.7 6267.4 6276.1 6285.3 5938.7 5967.3 5976.8 5987.8 6043.5 6009.4 6082.6 6092.5 6094.5 6130.0 5976.6 6001.6 6007.0 6008.7 6014.9 5910.1 5963.4 5970.6 5974.8 5992.6 5743.1 5797.9 5925.9 5963.9 5985.6 6030.6 6056.3 6078.4 6094.2 6094.3 5929.6 5952.1 5952.2 5960.7 5963.5 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | [#1] ext.html Cycles:180 Average:57100.96 Median:23195.10 stddev:106647.66 (459.8%) stddev-sans-first:106862.47 03:56:42 INFO - PROCESS | 32569 | Values: 602.9 662.6 664.5 672.4 720.2 40355.2 40691.2 41017.0 41057.6 41080.6 42203.0 42857.8 42942.4 43012.6 43056.0 8868.7 9093.8 9098.8 9108.5 9172.4 8911.9 9055.5 9094.9 9346.9 9355.3 9335.8 9337.5 9349.7 9388.7 9430.6 9246.3 9272.4 9362.5 9368.7 9370.3 9197.1 9282.7 9333.0 9334.5 9334.8 44631.0 45069.5 45314.1 45407.0 45419.8 3673.7 3809.8 3823.5 3920.8 4187.2 35243.1 35314.3 35464.6 35518.0 35601.8 4503.5 4544.1 4572.4 4575.9 4615.5 287332.0 288846.6 289650.0 290443.0 291536.0 58860.4 59236.4 59260.0 59285.7 59581.7 66478.7 72849.6 74467.0 74547.6 74975.3 18649.5 18837.8 18931.6 19006.5 19037.6 14468.0 14555.5 14574.3 14577.3 14654.1 21038.6 21266.4 21311.6 21311.7 21349.4 7498.4 7538.8 7586.3 7644.0 7758.9 1155.6 1169.2 1175.6 1177.0 1248.7 34586.3 34958.3 35860.5 35933.6 35942.8 1191.7 1246.4 1247.4 1267.0 1327.5 16066.5 16143.3 16422.3 16481.8 16655.3 491127.0 538827.0 557724.0 567331.0 567857.0 58844.4 59342.7 59495.0 59501.7 59990.0 1522.2 1524.3 1535.7 1554.5 1600.1 31906.0 32646.0 32698.7 32736.5 32884.9 57246.0 57309.0 58061.7 58089.7 58168.4 321598.0 322399.0 325142.0 326635.0 326900.0 31560.7 31809.4 32068.2 32235.0 32673.3 52143.5 52615.2 53311.0 53699.7 53865.2 38499.2 38721.0 43003.6 43280.4 43348.8 40997.4 41285.4 41717.2 42325.0 42999.4 41140.8 43235.1 44018.6 44547.8 45057.0 35843.0 35849.5 36111.3 36238.5 37081.6 28808.4 29300.3 29376.9 29574.1 29574.6 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | [#2] jquery.html Cycles:180 Average:28648.19 Median:2059.42 stddev:79630.06 (3866.6%) stddev-sans-first:79825.24 03:56:42 INFO - PROCESS | 32569 | Values: 423.5 430.2 432.7 433.3 442.6 18708.2 19311.6 19366.4 19464.6 20152.1 12037.5 12174.3 12194.3 17808.8 18295.5 5176.7 5293.2 5298.1 5298.5 5302.0 5389.0 5673.8 5777.1 5803.6 5810.2 5843.9 5855.4 5857.6 5862.2 5863.5 5446.9 5760.0 5764.9 5782.5 5800.4 5158.6 5207.6 5214.8 5232.6 5237.0 14271.7 14287.9 14301.6 14374.6 16573.9 2423.6 2455.3 2467.4 2709.5 2875.2 10053.6 10141.5 10384.1 10518.2 10556.7 2038.9 2049.7 2095.0 2101.5 2138.8 80106.6 82713.6 83343.0 84152.6 84507.9 10441.3 10734.4 10791.8 11042.0 11297.2 15105.3 15164.5 15170.2 15188.1 15197.0 8142.4 8423.7 8483.2 8499.2 8534.4 8405.8 8478.7 8602.6 8632.0 8645.9 4716.7 4759.7 4767.0 4773.7 4811.0 1976.7 1984.7 2024.2 2069.2 2099.6 1041.7 1081.7 1090.5 1117.3 1125.1 18181.5 18643.6 18885.7 18913.1 19699.7 1073.5 1092.6 1134.7 1160.2 1162.2 10680.8 10798.7 10818.8 10852.5 11064.1 468398.0 469025.0 469721.0 470981.0 525357.7 96590.5 97513.0 98679.5 100099.5 100904.5 1074.0 1111.3 1156.4 1157.6 1159.5 16715.7 16968.3 17141.7 17186.4 17326.7 39342.4 39897.2 39947.2 40208.8 41327.4 55569.7 56671.4 56719.1 60772.4 64151.4 9128.9 9182.4 9213.8 9278.1 9289.3 8750.7 11762.7 12715.9 13682.2 13918.7 11240.6 11626.2 11800.4 12119.2 12148.3 11132.8 11729.4 11925.6 11954.9 12009.7 11307.5 11546.4 11784.6 11938.3 12646.2 8834.2 8943.1 8948.4 9065.5 9228.5 11892.3 12416.9 12522.6 12650.9 12855.7 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | [#3] mootools.html Cycles:180 Average:5533.93 Median:4985.04 stddev:3007.93 (60.3%) stddev-sans-first:3001.12 03:56:42 INFO - PROCESS | 32569 | Values: 1503.4 1511.7 1687.6 1857.8 1869.3 8186.5 8271.6 8372.2 8404.0 8433.4 8361.2 8436.0 8441.5 8460.7 8499.8 2341.6 2358.3 2363.8 2369.5 2372.5 2344.9 2364.6 2406.0 2419.9 2422.7 2363.7 2391.9 2392.3 2413.5 2426.3 2339.7 2400.0 2403.1 2403.8 2413.2 2345.7 2381.8 2384.5 2389.2 2398.5 8372.8 8382.4 8432.7 8433.0 8455.0 5181.2 5256.7 5262.8 5270.8 5280.4 3209.3 3210.0 3225.2 3374.2 3390.8 1069.5 1129.3 1143.7 1144.4 1148.6 11388.9 11444.3 11494.9 11512.3 11569.7 4287.9 4293.3 4369.3 4380.7 4385.2 9176.1 9316.9 9330.1 9335.1 9365.1 4939.1 4973.2 4983.1 4987.0 5001.3 4018.8 4637.1 4652.4 4710.0 4736.7 4017.9 4023.3 4110.9 4126.0 4141.1 1291.3 1331.1 1333.1 1333.6 1338.9 1067.8 1072.0 1081.8 1087.5 1116.4 5772.8 5796.3 5934.2 6042.2 6120.1 424.3 438.0 455.2 466.3 468.1 4066.2 4187.5 4218.8 4236.8 4280.2 9809.6 10045.3 10049.3 10214.0 10240.7 9960.7 10103.9 10231.7 10242.9 10267.7 7649.5 7665.9 7704.4 7705.2 7931.5 5660.8 5720.5 5750.5 5751.2 5910.7 9001.4 9098.2 9146.2 9182.0 9202.6 9044.3 9259.2 9313.5 9329.0 9500.5 6676.1 7189.9 7274.7 7499.6 7540.0 7810.0 7925.0 7935.6 7940.8 7956.9 7076.9 7207.3 7219.9 7238.1 7359.6 7124.9 7168.7 7184.0 7190.0 7294.2 6869.4 6955.8 6965.6 6985.1 6990.8 5081.5 5119.5 5205.7 5274.3 5303.4 5117.9 5148.5 5155.9 5163.0 5318.2 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | [#4] prototype.html Cycles:180 Average:5865.43 Median:6743.53 stddev:1808.61 (26.8%) stddev-sans-first:1765.28 03:56:42 INFO - PROCESS | 32569 | Values: 327.6 332.9 343.4 353.6 358.7 6618.9 6635.5 6711.1 6716.6 6792.4 6560.6 6647.1 6650.8 6653.9 6699.5 4955.5 4957.0 4966.9 4974.4 4986.0 4992.8 4996.5 4998.9 5004.9 5010.9 4914.5 4922.3 4926.8 4931.1 4950.8 4746.6 4914.8 4941.7 4955.5 4963.8 4216.3 4239.2 4250.8 4256.2 4263.2 6324.4 6392.4 6398.2 6413.1 6437.1 5719.3 5738.4 5776.7 5782.3 5785.5 6950.8 6954.4 6958.3 6960.3 6988.4 4595.1 4755.5 4759.1 4764.3 4779.1 7181.7 7254.4 7289.6 7294.1 7309.5 4830.3 4860.8 4864.8 4865.1 4875.9 4915.0 4915.3 4919.5 4929.6 4933.5 5743.7 5753.8 5755.9 5769.8 5770.8 6760.5 7034.2 7035.7 7036.6 7082.2 1710.4 1720.7 1723.7 1733.5 1734.2 1103.2 1115.0 1127.9 1133.1 1141.6 6582.7 6726.6 6797.7 6813.9 6910.9 7210.2 7219.2 7270.8 7316.6 7352.0 6815.0 6855.5 6886.6 6899.5 6899.7 3933.4 3960.2 3962.0 3962.5 3967.1 7266.1 7509.8 7513.2 7513.9 7518.7 7435.6 7447.7 7453.7 7458.2 7479.4 7552.2 7559.4 7566.4 7598.5 7616.6 7168.7 7283.8 7294.8 7350.2 7350.7 7138.1 7247.8 7262.2 7263.9 7268.7 7467.6 7522.3 7538.6 7554.1 7575.0 5002.5 5051.8 5053.5 5053.8 5059.3 7034.4 7264.4 7277.3 7282.3 7285.1 7104.3 7120.1 7125.6 7144.6 7146.1 7065.1 7081.9 7089.8 7091.1 7092.5 6975.7 6977.7 6978.8 6982.3 6996.4 6937.8 7096.2 7105.0 7156.0 7175.4 6785.3 6951.6 6970.4 6997.2 7051.8 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - PROCESS | 32569 | [#5] yui.html Cycles:180 Average:15820.03 Median:25477.77 stddev:18276.18 (71.7%) stddev-sans-first:18292.71 03:56:42 INFO - PROCESS | 32569 | Values: 814.6 907.0 912.3 917.7 923.6 14220.9 14385.1 14402.3 14405.9 14422.2 14110.8 14143.3 14172.1 14178.1 14186.9 861.5 897.2 923.1 923.4 925.4 910.0 912.4 916.8 918.2 919.5 949.7 951.4 956.0 957.1 957.2 948.1 948.8 949.3 949.5 949.9 701.8 702.0 702.3 702.6 703.9 14978.8 15019.5 15030.8 15036.9 15061.4 14620.0 14658.2 14673.5 14759.6 14993.0 10954.9 11310.9 12542.9 12558.9 12647.4 3959.2 3974.4 3984.9 3987.1 3994.9 54790.5 54994.0 55105.4 55336.4 56399.4 11134.7 11541.5 11675.6 11847.3 12023.7 20064.5 20073.4 20085.5 20088.6 20106.1 8538.4 8584.8 8652.6 8717.3 8744.7 4853.4 4946.4 4957.1 5001.0 5060.2 3431.1 3459.3 3509.9 3522.8 3527.2 658.3 663.1 664.1 669.1 670.4 681.0 783.8 786.9 799.4 809.7 9897.8 10176.1 10260.8 10281.6 10452.3 751.8 753.6 785.2 798.8 806.4 4579.3 4633.8 4710.1 4722.6 4783.4 65818.7 66730.7 66742.0 67083.7 67468.7 54954.2 57824.4 58154.0 59119.7 59314.7 52919.0 53230.7 53443.2 53862.0 54196.5 9123.9 9161.5 9246.2 9248.5 9293.9 39890.6 39899.2 40883.6 41091.0 41175.0 46321.8 50432.0 50978.0 51290.5 51991.0 11649.9 11915.3 12357.3 12901.2 13119.3 14336.6 14424.4 14852.7 14909.6 15010.2 13075.6 14149.2 14164.6 14407.5 14690.3 12680.7 13294.6 13501.0 13549.3 13784.0 12666.2 12792.7 13109.6 13386.2 13418.9 10999.9 11174.7 11377.1 11443.8 11470.1 11275.3 11534.1 11567.2 11626.7 11761.8 03:56:42 INFO - PROCESS | 32569 | -------- Summary: end -------- 03:56:42 INFO - PROCESS | 32569 | 03:56:42 INFO - TEST-INFO | 32569: exit 0 03:56:43 INFO - TEST-OK | dromaeo_css | took 1109213ms 03:56:43 INFO - TEST-START | kraken 03:56:43 INFO - operating with platform_type : linux_ 03:56:43 INFO - Initialising browser for kraken test... 03:56:43 INFO - TEST-INFO | started process 341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLNnwaW/profile http://localhost:46237/getInfo.html) 03:56:46 INFO - PROCESS | 341 | 03:56:46 INFO - PROCESS | 341 | (process:421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:56:47 INFO - PROCESS | 341 | __metrics Screen width/height:1600/1200 03:56:47 INFO - PROCESS | 341 | colorDepth:24 03:56:47 INFO - PROCESS | 341 | Browser inner width/height: 1024/697 03:56:47 INFO - PROCESS | 341 | __metrics 03:56:48 ERROR - PROCESS | 341 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:56:48 INFO - TEST-INFO | 341: exit 0 03:56:48 INFO - Browser initialized. 03:56:48 INFO - Running cycle 1/1 for kraken test... 03:56:48 INFO - TEST-INFO | started process 473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLNnwaW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:50 INFO - PROCESS | 473 | 03:56:50 INFO - PROCESS | 473 | (process:540): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:57:00 INFO - PROCESS | 473 | RSS: Main: 152768512 03:57:00 INFO - PROCESS | 473 | 03:57:03 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46237/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:04 INFO - PROCESS | 473 | RSS: Main: 157614080 03:57:04 INFO - PROCESS | 473 | 03:57:06 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46237/tests/kraken/driver.html?testName=audio-dft) 03:57:07 INFO - PROCESS | 473 | RSS: Main: 157843456 03:57:07 INFO - PROCESS | 473 | 03:57:10 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46237/tests/kraken/driver.html?testName=audio-fft) 03:57:10 INFO - PROCESS | 473 | RSS: Main: 157552640 03:57:10 INFO - PROCESS | 473 | 03:57:12 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46237/tests/kraken/driver.html?testName=audio-oscillator) 03:57:13 INFO - PROCESS | 473 | RSS: Main: 157417472 03:57:13 INFO - PROCESS | 473 | 03:57:15 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:16 INFO - PROCESS | 473 | RSS: Main: 157302784 03:57:16 INFO - PROCESS | 473 | 03:57:19 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46237/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:20 INFO - PROCESS | 473 | RSS: Main: 157663232 03:57:20 INFO - PROCESS | 473 | 03:57:23 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46237/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:24 INFO - PROCESS | 473 | RSS: Main: 157556736 03:57:24 INFO - PROCESS | 473 | 03:57:26 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46237/tests/kraken/driver.html?testName=json-parse-financial) 03:57:27 INFO - PROCESS | 473 | RSS: Main: 157417472 03:57:27 INFO - PROCESS | 473 | 03:57:28 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:29 INFO - PROCESS | 473 | RSS: Main: 157671424 03:57:29 INFO - PROCESS | 473 | 03:57:31 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:31 INFO - PROCESS | 473 | RSS: Main: 157757440 03:57:31 INFO - PROCESS | 473 | 03:57:33 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:34 INFO - PROCESS | 473 | RSS: Main: 157626368 03:57:34 INFO - PROCESS | 473 | 03:57:37 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:37 INFO - PROCESS | 473 | RSS: Main: 158765056 03:57:37 INFO - PROCESS | 473 | 03:57:40 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:40 INFO - PROCESS | 473 | RSS: Main: 158031872 03:57:40 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | Cycle 1(1): loaded http://localhost:46237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46237/tests/kraken/driver.html?testName=ai-astar) 03:57:42 INFO - PROCESS | 473 | RSS: Main: 159551488 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | __start_tp_report 03:57:42 INFO - PROCESS | 473 | _x_x_mozilla_page_load 03:57:42 INFO - PROCESS | 473 | _x_x_mozilla_page_load_details 03:57:42 INFO - PROCESS | 473 | |i|pagename|runs| 03:57:42 INFO - PROCESS | 473 | |0;ai-astar;110;111;105;110;113;112;101;111;113;111 03:57:42 INFO - PROCESS | 473 | |1;audio-beat-detection;152;133;154;174;145;157;152;128;197;127 03:57:42 INFO - PROCESS | 473 | |2;audio-dft;163;161;164;162;161;160;162;163;161;164 03:57:42 INFO - PROCESS | 473 | |3;audio-fft;75;77;74;167;79;76;76;75;183;76 03:57:42 INFO - PROCESS | 473 | |4;audio-oscillator;92;93;153;93;92;93;148;94;92;148 03:57:42 INFO - PROCESS | 473 | |5;imaging-gaussian-blur;117;119;117;117;118;117;118;118;118;122 03:57:42 INFO - PROCESS | 473 | |6;imaging-darkroom;149;147;147;148;147;147;147;147;148;147 03:57:42 INFO - PROCESS | 473 | |7;imaging-desaturate;94;95;96;95;95;95;95;95;95;95 03:57:42 INFO - PROCESS | 473 | |8;json-parse-financial;53;55;56;56;56;55;56;76;55;59 03:57:42 INFO - PROCESS | 473 | |9;json-stringify-tinderbox;58;58;57;58;58;57;57;58;58;58 03:57:42 INFO - PROCESS | 473 | |10;stanford-crypto-aes;73;74;74;73;74;77;83;84;75;74 03:57:42 INFO - PROCESS | 473 | |11;stanford-crypto-ccm;126;113;114;113;123;115;112;118;130;123 03:57:42 INFO - PROCESS | 473 | |12;stanford-crypto-pbkdf2;161;160;165;162;158;164;164;159;162;158 03:57:42 INFO - PROCESS | 473 | |13;stanford-crypto-sha256-iterative;66;69;65;67;68;69;65;67;68;65 03:57:42 INFO - PROCESS | 473 | __end_tp_report 03:57:42 INFO - PROCESS | 473 | __start_cc_report 03:57:42 INFO - PROCESS | 473 | _x_x_mozilla_cycle_collect,867 03:57:42 INFO - PROCESS | 473 | __end_cc_report 03:57:42 INFO - PROCESS | 473 | __startTimestamp1464433062871__endTimestamp 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | ------- Summary: start ------- 03:57:42 INFO - PROCESS | 473 | Number of tests: 14 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.80 (3.4%) stddev-sans-first:4.03 03:57:42 INFO - PROCESS | 473 | Values: 110.0 111.0 105.0 110.0 113.0 112.0 101.0 111.0 113.0 111.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:153.00 stddev:21.47 (14.0%) stddev-sans-first:22.77 03:57:42 INFO - PROCESS | 473 | Values: 152.0 133.0 154.0 174.0 145.0 157.0 152.0 128.0 197.0 127.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.41 03:57:42 INFO - PROCESS | 473 | Values: 163.0 161.0 164.0 162.0 161.0 160.0 162.0 163.0 161.0 164.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#3] audio-fft Cycles:10 Average:95.80 Median:76.00 stddev:41.93 (55.2%) stddev-sans-first:43.80 03:57:42 INFO - PROCESS | 473 | Values: 75.0 77.0 74.0 167.0 79.0 76.0 76.0 75.0 183.0 76.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.50 stddev:27.55 (29.8%) stddev-sans-first:28.46 03:57:42 INFO - PROCESS | 473 | Values: 92.0 93.0 153.0 93.0 92.0 93.0 148.0 94.0 92.0 148.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.56 03:57:42 INFO - PROCESS | 473 | Values: 117.0 119.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 122.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 03:57:42 INFO - PROCESS | 473 | Values: 149.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 03:57:42 INFO - PROCESS | 473 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.00 stddev:6.60 (11.8%) stddev-sans-first:6.78 03:57:42 INFO - PROCESS | 473 | Values: 53.0 55.0 56.0 56.0 56.0 55.0 56.0 76.0 55.0 59.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:57:42 INFO - PROCESS | 473 | Values: 58.0 58.0 57.0 58.0 58.0 57.0 57.0 58.0 58.0 58.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:74.50 stddev:4.07 (5.5%) stddev-sans-first:4.16 03:57:42 INFO - PROCESS | 473 | Values: 73.0 74.0 74.0 73.0 74.0 77.0 83.0 84.0 75.0 74.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:120.50 stddev:6.36 (5.3%) stddev-sans-first:6.17 03:57:42 INFO - PROCESS | 473 | Values: 126.0 113.0 114.0 113.0 123.0 115.0 112.0 118.0 130.0 123.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:2.54 (1.6%) stddev-sans-first:2.69 03:57:42 INFO - PROCESS | 473 | Values: 161.0 160.0 165.0 162.0 158.0 164.0 164.0 159.0 162.0 158.0 03:57:42 INFO - PROCESS | 473 | 03:57:42 INFO - PROCESS | 473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.60 (2.4%) stddev-sans-first:1.66 03:57:42 INFO - PROCESS | 473 | Values: 66.0 69.0 65.0 67.0 68.0 69.0 65.0 67.0 68.0 65.0 03:57:42 INFO - PROCESS | 473 | -------- Summary: end -------- 03:57:42 INFO - PROCESS | 473 | 03:57:43 INFO - TEST-INFO | 473: exit 0 03:57:43 INFO - TEST-OK | kraken | took 60754ms 03:57:43 INFO - SUITE-END | took 1169s 03:57:44 INFO - Completed test suite (00:19:30) 03:57:44 INFO - javascript benchmark 03:57:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3379.9860041987404, 3393.609734880488, 3441.741869359797, 3462.047936817375, 3474.913127171819, 5721.713914304284, 5737.713114344282, 5775.682337471438, 5801.622894511854, 5805.535557155428, 5730.083186690131, 5798.565107616935, 5800.274965629296, 5822.9417705822925, 5828.154917536955, 5236.21456781483, 5251.711155886424, 5296.602754793406, 5323.467653234684, 5331.840044798662, 5110.463401342861, 5216.76524556394, 5219.086659834514, 5403.540699040586, 5409.513143817056, 5079.161938280179, 5166.664166829163, 5182.974085129569, 5198.090334191501, 5249.8950020999555, 5218.1650935850275, 5220.008198442303, 5226.634135610509, 5230.267762513251, 5261.86845328866, 5015.398152221756, 5071.670341427833, 5133.563647090002, 5180.663256888328, 5203.453637368098, 5613.971930140364, 5671.347795003545, 5695.971520142414, 5710.571707121982, 5752.108423194411, 6078.8784224315705, 6129.019356902919, 6140.785072522441, 6141.600795948294, 6146.231721034871, 6104.633721976651, 6187.81436556904, 6198.008318669036, 6214.65819379934, 6218.22272215973, 5798.217240672539, 5803.042497987827, 5815.273090863642, 5815.854603634901, 5841.357450680422, 6345.17512723343, 6345.238571371373, 6359.427651511386, 6387.010013447923, 6402.839929001812, 5764.481196692234, 6018.127371531104, 6092.786752463642, 6111.786087486917, 6125.693715314216, 6061.151438798572, 6079.604825686316, 6081.0, 6088.939110608837, 6136.723847426876, 6029.788957386558, 6056.182415373868, 6064.878702425926, 6065.75736970525, 6070.6357618543025, 5987.042073268256, 6102.267727872683, 6121.6358891611635, 6142.345304543789, 6192.8761424771255, 4690.929636055462, 4697.412823397075, 4701.2242979908615, 4712.552307530779, 4715.976420117878, 4174.791260436966, 4194.203101410783, 4196.748195108304, 4198.055437526593, 4235.576442355739, 5766.04860198071, 5963.880722385528, 6007.339192688801, 6015.3383127855905, 6040.728167232485, 6097.878042439126, 6138.600990935575, 6140.846478837975, 6159.414855588801, 6165.0444181152, 5739.71301434935, 5863.384344643836, 5870.207521984563, 5878.941210587925, 5898.8820223595285, 5300.496452836975, 5311.575073994071, 5326.414094449608, 5350.3312085989255, 5356.758945847446, 6408.327125651833, 6408.67956602168, 6420.903686444707, 6431.196100487439, 6449.226092868886, 5930.495907847881, 6178.258608966953, 6209.96895015522, 6230.470410015199, 6234.906476402857, 6217.658028808459, 6259.749610015549, 6267.435930766253, 6276.089966954674, 6285.308616052139, 5938.673372964528, 5967.254093238345, 5976.7908123215475, 5987.790427335022, 6043.486303664238, 6009.36901625323, 6082.635041897501, 6092.543059270661, 6094.512439004958, 6130.0, 5976.641401515923, 6001.5798894077, 6006.969965150146, 6008.7296071676, 6014.939850601438, 5910.113482977587, 5963.403659634002, 5970.552208584287, 5974.761009559569, 5992.550558708202, 5743.052396354555, 5797.942020579909, 5925.911111333247, 5963.940360596339, 5985.581009329305, 6030.5778595497895, 6056.3035250946705, 6078.422549857756, 6094.238220222473, 6094.268687757498, 5929.6145750526075, 5952.136940143741, 5952.226210592596, 5960.672163031075, 5963.493103086286], "value": 5670.801475460536, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.8944934636437, 662.6421732264578, 664.5447868210273, 672.4116398151618, 720.2437440687277, 40355.19289614209, 40691.18617627646, 41017.0, 41057.58942410579, 41080.58919410805, 42203.0, 42857.7857110714, 42942.35586466198, 43012.56987430125, 43056.0, 8868.733937981855, 9093.772655683595, 9098.818023639524, 9108.499032553207, 9172.449653020807, 8911.866322005142, 9055.547222638874, 9094.909050909473, 9346.906530934672, 9355.345125841193, 9335.76660583484, 9337.486438245927, 9349.719508414724, 9388.718338449857, 9430.622775089023, 9246.306527010467, 9272.443653380818, 9362.531873406302, 9368.718938431857, 9370.250379969586, 9197.080291970817, 9282.675106371245, 9333.0, 9334.486603236819, 9334.766630834216, 44631.0, 45069.54930450719, 45314.093718125456, 45407.0, 45419.77290113561, 3673.6510031547227, 3809.771413715186, 3823.5220597425323, 3920.764754114734, 4187.198229447343, 35243.1189220269, 35314.29371412583, 35464.645353546395, 35518.0, 35601.82199089014, 4503.504614492404, 4544.068465964469, 4572.359869618256, 4575.862724118282, 4615.46922103959, 287332.0, 288846.5557672219, 289650.0, 290443.0, 291536.0, 58860.411395885494, 59236.40763592309, 59260.0, 59285.70357148186, 59581.702091489264, 66478.66760666166, 72849.6357518209, 74467.0, 74547.62726186334, 74975.25024749682, 18649.533761655795, 18837.811621883604, 18931.62136757257, 19006.52483687891, 19037.61924761497, 14468.0, 14555.490557830424, 14574.271286435636, 14577.344019519147, 14654.120752754869, 21038.579228415347, 21266.36200913975, 21311.573768524853, 21311.68032479514, 21349.35951921445, 7498.3626391756225, 7538.773836784905, 7586.317231449196, 7644.0, 7758.883616745753, 1155.6186458468685, 1169.2049406403728, 1175.5767923547517, 1177.0054304113012, 1248.731522722619, 34586.30827383438, 34958.30083398369, 35860.46209306862, 35933.64066359303, 35942.8202858984, 1191.74377508836, 1246.407956220806, 1247.4137155536882, 1266.9927407710893, 1327.462377737018, 16066.518004459651, 16143.273552690158, 16422.343106275614, 16481.752773708406, 16655.25051372691, 491127.0, 538827.0, 557724.0, 567331.0, 567857.0, 58844.41155588475, 59342.703286483295, 59495.0, 59501.70249148727, 59990.0, 1522.1704171226709, 1524.2683511914122, 1535.6544777425213, 1554.5258696097799, 1600.1039417926, 31906.0, 32646.0, 32698.673013270516, 32736.50895236621, 32884.94136539883, 57246.0, 57309.0, 58061.70969145127, 58089.709551451975, 58168.4183158163, 321598.0, 322399.0, 325142.0, 326635.0, 326900.0, 31560.684393156695, 31809.363812723153, 32068.19829504281, 32235.0, 32673.34653306968, 52143.47856521386, 52615.21077183922, 53311.0, 53699.73150134224, 53865.192022118914, 38499.2300154001, 38721.0, 43003.56996429995, 43280.350794737475, 43348.783256083516, 40997.38503922503, 41285.38071928863, 41717.165656687306, 42325.0, 42999.355009674255, 41140.794296028325, 43235.13529729451, 44018.559814402724, 44547.777261113486, 45057.0, 35843.0, 35849.46225806563, 36111.27777444489, 36238.45642315315, 37081.629183708894, 28808.423831522832, 29300.267493312836, 29376.853115734284, 29574.112776616737, 29574.556381653863], "value": 21066.582635268547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.5150752388515, 430.18909355864184, 432.74251820167, 433.2980571474212, 442.63261492960845, 18708.15813288402, 19311.613767724655, 19366.41900742978, 19464.610707785836, 20152.093155807986, 12037.458314375852, 12174.269543827377, 12194.268343899372, 17808.842425242383, 18295.54261143469, 5176.689398636075, 5293.15309550472, 5298.125809241471, 5298.523132918037, 5301.973490132544, 5388.973055134738, 5673.801416950408, 5777.0756678931375, 5803.6227645203135, 5810.215620891189, 5843.883122337572, 5855.355910849803, 5857.619254748449, 5862.179294898718, 5863.5016023638045, 5446.891062178754, 5760.049591817345, 5764.942350576483, 5782.537397008229, 5800.419958004187, 5158.561522270612, 5207.609429292818, 5214.765335559909, 5232.581393488512, 5236.973815130938, 14271.714565708731, 14287.928560357132, 14301.570952871327, 14374.568762937128, 16573.917130414393, 2423.587990041697, 2455.3493324269084, 2467.395488105408, 2709.512287788197, 2875.2236896037953, 10053.597856085747, 10141.54363053657, 10384.065434110966, 10518.158547316196, 10556.736081597945, 2038.8776673399643, 2049.6720524716125, 2094.979050209509, 2101.495641046153, 2138.7754285799924, 80106.59946700287, 82713.58643206806, 83343.0, 84152.57923710403, 84507.92952422936, 10441.32131411471, 10734.35593864355, 10791.784164316827, 11042.0, 11297.209195356247, 15105.3202605883, 15164.469243576423, 15170.24148792578, 15188.088714677155, 15197.0, 8142.4300298978505, 8423.747287581382, 8483.194096560817, 8499.150084991576, 8534.402591818638, 8405.831883362422, 8478.74563763088, 8602.61288242018, 8632.0, 8645.91354086451, 4716.740579268105, 4759.690620109682, 4766.993588079045, 4773.689710168828, 4810.979388656702, 1976.733141025972, 1984.7419835421304, 2024.2409096588779, 2069.172331067585, 2099.601075795594, 1041.6510468992822, 1081.691717860406, 1090.5092708281147, 1117.2961034548182, 1125.1448898836943, 18181.45455636333, 18643.627127457374, 18885.716714249298, 18913.14890829916, 19699.704504432444, 1073.4632683658172, 1092.6448904106198, 1134.704976706046, 1160.1994623709613, 1162.1632424654235, 10680.78638427227, 10798.67603971882, 10818.783624327469, 10852.511636976355, 11064.059554937921, 468398.0, 469025.0, 469721.0, 470981.0, 525357.6979793555, 96590.51704741572, 97513.0, 98679.50660246653, 100099.49950250202, 100904.49547752214, 1073.9946300268448, 1111.3165403277087, 1156.4102307822902, 1157.583270022791, 1159.4608507044265, 16715.665686685956, 16968.321267149175, 17141.742873856652, 17186.398476053277, 17326.653466930842, 39342.40986385264, 39897.2020559593, 39947.2010559793, 40208.798956005034, 41327.38008929929, 55569.72215138898, 56671.433285666615, 56719.14921276102, 60772.39227607667, 64151.35848641454, 9128.908710912805, 9182.449053056838, 9213.76965575866, 9278.11857873501, 9289.34974551775, 8750.69372571957, 11762.706102328566, 12715.93642031784, 13682.15290935711, 13918.652033699238, 11240.606578769704, 11626.186166968231, 11800.409979501163, 12119.212251203644, 12148.271103733805, 11132.777344452903, 11729.35488548104, 11925.642230733092, 11954.940225298818, 12009.699757506132, 11307.547698091985, 11546.42267886619, 11784.646460606196, 11938.343391113573, 12646.177998430072, 8834.249088827522, 8943.105689431004, 8948.418352807046, 9065.501397423204, 9228.538573071186, 11892.286462812259, 12416.937915310365, 12522.624321270376, 12650.936745316214, 12855.742885142432], "value": 9231.35256402128, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.4286970951036, 1511.6674331647037, 1687.561234079139, 1857.7863545692232, 1869.2616416515477, 8186.467879587823, 8271.627776750045, 8372.246497815195, 8404.033536143354, 8433.40966132371, 8361.163883611636, 8436.029856566496, 8441.451305665127, 8460.703875364363, 8499.830003399928, 2341.648752687102, 2358.3043002314357, 2363.7636236376397, 2369.5497855407502, 2372.489914668346, 2344.9062037518565, 2364.574376612209, 2405.9639105413435, 2419.9395015124587, 2422.6608274841537, 2363.7163540375095, 2391.8923648435775, 2392.270357540949, 2413.4569721812627, 2426.259990702844, 2339.7075365579303, 2400.0399840063938, 2403.098837935774, 2403.771641694036, 2413.179518963561, 2345.7185137783404, 2381.773731495505, 2384.511175209078, 2389.2235023617395, 2398.4603464220586, 8372.790680232982, 8382.413231073828, 8432.662693492253, 8432.957835210786, 8454.957725211334, 5181.1969144782615, 5256.737163141827, 5262.763175657066, 5270.815521456769, 5280.392754833205, 3209.261869769966, 3209.9839500802345, 3225.161458020908, 3374.156460884779, 3390.8135052572097, 1069.470612047034, 1129.3393364881554, 1143.702637314296, 1144.416347662698, 1148.5578052449866, 11388.943055284753, 11444.256123351955, 11494.885051149466, 11512.251703639236, 11569.710757231052, 4287.871363859089, 4293.291606884892, 4369.3227549729845, 4380.6933514653665, 4385.232584297735, 9176.082391760903, 9316.8602470963, 9330.113639204264, 9335.06649335061, 9365.11031452011, 4939.135651261015, 4973.204287314013, 4983.053219888209, 4987.0275296317595, 5001.349824522788, 4018.814449737276, 4637.142128706133, 4652.371929789435, 4710.0, 4736.73947932867, 4017.859374921922, 4023.2556976959354, 4110.897227569335, 4125.97937010313, 4141.130362623882, 1291.2962435472502, 1331.10150648312, 1333.133463248896, 1333.5599252246736, 1338.9062765606313, 1067.765091679829, 1071.9517621707041, 1081.799867024603, 1087.5377964365114, 1116.3971455414148, 5772.826815195551, 5796.304443466811, 5934.198883150806, 6042.184305118841, 6120.14317995481, 424.2893153967093, 437.9956200437955, 455.1693159982978, 466.2889094131477, 468.0802223630582, 4066.1867626474823, 4187.513432731336, 4218.767967761742, 4236.76697781625, 4280.165367753259, 9809.558569864374, 10045.347052441568, 10049.29654924163, 10214.029667181754, 10240.743981400376, 9960.651377201762, 10103.949480252551, 10231.7442063949, 10242.948785256027, 10267.691969240936, 7649.464537482434, 7665.8850117248285, 7704.422168337397, 7705.15243323234, 7931.484453510619, 5660.801871934463, 5720.48515633595, 5750.5112065474905, 5751.166080918159, 5910.674912879833, 9001.36990410665, 9098.226650734498, 9146.176844084064, 9182.0, 9202.631894724136, 9044.276457883485, 9259.166674999282, 9313.487758173365, 9329.020452852625, 9500.47747373901, 6676.0987266718375, 7189.856202875809, 7274.672639731119, 7499.575080734643, 7540.019797426299, 7810.0, 7924.960375198087, 7935.6032198391, 7940.801479963047, 7956.92043079585, 7076.929230707627, 7207.279272072751, 7219.891701624585, 7238.131424229126, 7359.595222262827, 7124.857502850017, 7168.67740951648, 7184.0, 7190.0, 7294.234105418855, 6869.381755641816, 6955.791326260221, 6965.582065076112, 6985.057017302599, 6990.790276291719, 5081.5426611605135, 5119.513646203604, 5205.687658740488, 5274.287971123849, 5303.416624171416, 5117.948820511747, 5148.510891465305, 5155.922661160011, 5163.044836705221, 5318.202269659582], "value": 4452.209885509971, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6003276003276, 332.9250918543328, 343.3596342820639, 353.6163262859797, 358.68256592915264, 6618.900716489256, 6635.502337324702, 6711.127553418055, 6716.563423377477, 6792.354726300993, 6560.606363618174, 6647.069410282565, 6650.767223147191, 6653.900191497131, 6699.464042876571, 4955.479674634165, 4956.950430495685, 4966.900661986776, 4974.37820272466, 4986.027724593706, 4992.775325110379, 4996.4503904570465, 4998.900021999558, 5004.899902001957, 5010.899782004376, 4914.508549145093, 4922.310876477278, 4926.802927882881, 4931.087748766489, 4950.801967921278, 4746.644001699887, 4914.754262286871, 4941.728204948727, 4955.4548999610015, 4963.776630051656, 4216.2832318505925, 4239.236937351276, 4250.829966801324, 4256.170046840867, 4263.168682106991, 6324.367563243685, 6392.392722691384, 6398.16823812906, 6413.070104834819, 6437.130987316699, 5719.256496655408, 5738.426157384228, 5776.740046697909, 5782.306123265193, 5785.450382213683, 6950.826229344307, 6954.4436445084275, 6958.2693817148975, 6960.338767817049, 6988.405985491239, 4595.058013107305, 4755.524447555217, 4759.071980963713, 4764.2615394613895, 4779.068081724065, 7181.712731490734, 7254.383377412873, 7289.599072051035, 7294.051773269441, 7309.451791115687, 4830.3237546743485, 4860.8298709545, 4864.756762161877, 4865.051314993542, 4875.926861097087, 4915.0415668944215, 4915.336429582032, 4919.458859525449, 4929.605631549467, 4933.506649335038, 5743.712814359265, 5753.827385178452, 5755.8561035974435, 5769.826905192851, 5770.769169233184, 6760.459163266927, 7034.155901291878, 7035.718571257093, 7036.612986285803, 7082.150141982995, 1710.435556266429, 1720.7332863406193, 1723.6983527882571, 1733.4626265857623, 1734.1849330814498, 1103.189155970361, 1115.041064684371, 1127.8984891359817, 1133.0538999935147, 1141.5547936304847, 6582.670866456658, 6726.596404215763, 6797.728090876409, 6813.863722725617, 6910.896336554955, 7210.206877243499, 7219.205887352387, 7270.781876543712, 7316.561006339637, 7352.0, 6814.965925170342, 6855.451563874878, 6886.552374095668, 6899.48253880961, 6899.655017249117, 3933.449317095609, 3960.2277555876326, 3961.980190099031, 3962.5244970603712, 3967.0677390813134, 7266.091738532684, 7509.812254693677, 7513.173550909396, 7513.924860751432, 7518.699252029857, 7435.591042492715, 7447.702091916262, 7453.664585093684, 7458.179600243969, 7479.439042071866, 7552.207018263003, 7559.395248380117, 7566.432517561205, 7598.518288933605, 7616.581088040211, 7168.677409516688, 7283.781486555412, 7294.817629559304, 7350.19147893742, 7350.669219885011, 7138.14342278909, 7247.818804529929, 7262.237465066092, 7263.891041634274, 7268.745593904188, 7467.58928258951, 7522.285382888617, 7538.623068846646, 7554.093508778982, 7575.0, 5002.474740152232, 5051.797928082836, 5053.494650534917, 5053.823116190915, 5059.266406371129, 7034.402075823612, 7264.40183159704, 7277.2722727726805, 7282.271772822887, 7285.052943117361, 7104.325089116525, 7120.1099862517185, 7125.572465652078, 7144.571325720473, 7146.142462904277, 7065.0815393998455, 7081.858362832818, 7089.751858684921, 7091.1490621125795, 7092.468064895051, 6975.686094125675, 6977.651117444209, 6978.825529361807, 6982.266861979419, 6996.440284777307, 6937.791866244021, 7096.219415864354, 7105.0, 7156.0, 7175.354218120394, 6785.287544807724, 6951.582905025714, 6970.442364610718, 6997.160340759141, 7051.823704407431], "value": 5261.618687611444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.6212011414693, 906.9705883821861, 912.3066469483191, 917.7155081924603, 923.6259314977432, 14220.857791422082, 14385.064970776892, 14402.279886005697, 14405.92797036016, 14422.206778627184, 14110.788338174936, 14143.292835358243, 14172.078814877026, 14178.149311041345, 14186.929065354685, 861.4745005546628, 897.1970086772335, 923.1322556796623, 923.4367036107968, 925.3707478914336, 910.026271889079, 912.3886995712888, 916.8487199612056, 918.2149262380668, 919.4713040001992, 949.6723630347519, 951.4148798488949, 955.9617615295415, 957.1337939165066, 957.2294303086013, 948.1087777489173, 948.8481842905137, 949.2785483032876, 949.4588084791671, 949.8765160529156, 701.7999870037066, 702.0171759536638, 702.3398005874461, 702.5573888450243, 703.8803403421431, 14978.775318370124, 15019.549413517612, 15030.774538381933, 15036.924815375962, 15061.397544098223, 14620.0, 14658.193799341032, 14673.486427975076, 14759.631009224748, 14993.0, 10954.945225273823, 11310.886891131066, 12542.937285313606, 12558.874411255862, 12647.43086561107, 3959.1883663848844, 3974.4435778990673, 3984.8804535863683, 3987.063040185554, 3994.940075898864, 54790.45209547893, 54994.0, 55105.448945510834, 55336.44663553353, 56399.43600563983, 11134.721631959266, 11541.538338466535, 11675.649730508097, 11847.348395838311, 12023.699407514881, 20064.498387540138, 20073.397798066082, 20085.49786255326, 20088.598228035356, 20106.09522571488, 8538.402311838236, 8584.828303433897, 8652.567371631394, 8717.30261579072, 8744.69393571222, 4853.4418541867435, 4946.3817022872145, 4957.132501812241, 5000.974995125074, 5060.240963855377, 3431.0736101252523, 3459.325431540876, 3509.9298014039578, 3522.8374636369936, 3527.206378564854, 658.318640207383, 663.1081195791653, 664.1001443044605, 669.1100835888257, 670.4133882852504, 680.9625470599066, 783.8079670480655, 786.9134395216522, 799.436397339874, 809.6599428240153, 9897.752556186153, 10176.135028522658, 10260.794784104277, 10281.640142594973, 10452.32059916103, 751.7563354861775, 753.6307209467321, 785.2343964634435, 798.7923139983646, 806.3871457692196, 4579.335996280521, 4633.7683115844075, 4710.057988402334, 4722.574968252874, 4783.378160839069, 65818.67090664516, 66730.66634666892, 66742.0, 67083.66458167679, 67468.66265668739, 54954.175687364725, 57824.42175578274, 58154.0, 59119.70440147858, 59314.70342648259, 52919.0, 53230.73384633052, 53443.19835202475, 53862.0, 54196.45803541914, 9123.863142053007, 9161.496117713323, 9246.167844893991, 9248.491332976751, 9293.907060929305, 39890.60109398869, 39899.2020159601, 40883.59116408798, 41090.9727256809, 41175.0, 46321.76839115783, 50432.0, 50978.0, 51290.48709512857, 51991.0, 11649.941750291195, 11915.285082895054, 12357.32034738098, 12901.225926444444, 13119.278439685528, 14336.641583960485, 14424.350904209545, 14852.737517310718, 14909.552713418614, 15010.174440405446, 13075.607731768063, 14149.151050936976, 14164.575062748134, 14407.495737649131, 14690.265486725835, 12680.74638507243, 13294.571531867161, 13501.0, 13549.322533873465, 13784.0, 12666.176698514568, 12792.6801829955, 13109.60671179866, 13386.19682819034, 13418.865811341762, 10999.890001099886, 11174.72063198394, 11377.146713996317, 11443.828342575034, 11470.082393408675, 11275.32348059119, 11534.077273818242, 11567.248128871597, 11626.651200463999, 11761.823572646588], "value": 7233.77539281525, "unit": "score"}], "name": "dromaeo_css", "value": 7561.372022336575, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 105.0, 110.0, 113.0, 112.0, 101.0, 111.0, 113.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 154.0, 174.0, 145.0, 157.0, 152.0, 128.0, 197.0, 127.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 162.0, 161.0, 160.0, 162.0, 163.0, 161.0, 164.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 167.0, 79.0, 76.0, 76.0, 75.0, 183.0, 76.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 153.0, 93.0, 92.0, 93.0, 148.0, 94.0, 92.0, 148.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 122.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 76.0, 55.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 73.0, 74.0, 77.0, 83.0, 84.0, 75.0, 74.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 113.0, 114.0, 113.0, 123.0, 115.0, 112.0, 118.0, 130.0, 123.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 165.0, 162.0, 158.0, 164.0, 164.0, 159.0, 162.0, 158.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 65.0, 67.0, 68.0, 69.0, 65.0, 67.0, 68.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1528.2, "alertThreshold": 2.0}]} 03:57:44 INFO - Return code: 0 03:57:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:57:44 ERROR - # TBPL SUCCESS # 03:57:44 INFO - Running post-action listener: _resource_record_post_action 03:57:44 INFO - Running post-run listener: _resource_record_post_run 03:57:45 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504233984; Read time: 28; Write time: 400244 03:57:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255426560; Read time: 0; Write time: 232732 03:57:45 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 244740096; Read time: 28; Write time: 167084 03:57:45 INFO - Running post-run listener: _upload_blobber_files 03:57:45 INFO - Blob upload gear active. 03:57:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:45 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 03:57:45 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'] 03:57:45 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 03:57:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:46 INFO - (blobuploader) - INFO - Done attempting. 03:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:47 INFO - (blobuploader) - INFO - Done attempting. 03:57:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:47 INFO - Return code: 0 03:57:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8617568713bc2a883faba351339c4d70c98604b066ca6c25fef487e78baf0210673494df6b38328071d816309d7c6abd884231cb44a4da2cbd6130713f5538b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfa53c9ffec3fce6cadb43bab967ddc0b8f6e447ae279f451f2a678d5286d7b70ca98cdfe263f191949442b5820c96af7d63a2a2c68b0188c36d6a760ca7cd4f"} 03:57:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:47 INFO - Contents: 03:57:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8617568713bc2a883faba351339c4d70c98604b066ca6c25fef487e78baf0210673494df6b38328071d816309d7c6abd884231cb44a4da2cbd6130713f5538b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfa53c9ffec3fce6cadb43bab967ddc0b8f6e447ae279f451f2a678d5286d7b70ca98cdfe263f191949442b5820c96af7d63a2a2c68b0188c36d6a760ca7cd4f"} 03:57:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:47 INFO - Copying logs to upload dir... 03:57:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.810932 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-28 03:57:47.295862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:47.299108) ========= 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=4300f881736b422476174874000001bc-1464431840.391827-1565704662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8617568713bc2a883faba351339c4d70c98604b066ca6c25fef487e78baf0210673494df6b38328071d816309d7c6abd884231cb44a4da2cbd6130713f5538b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfa53c9ffec3fce6cadb43bab967ddc0b8f6e447ae279f451f2a678d5286d7b70ca98cdfe263f191949442b5820c96af7d63a2a2c68b0188c36d6a760ca7cd4f"} build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8617568713bc2a883faba351339c4d70c98604b066ca6c25fef487e78baf0210673494df6b38328071d816309d7c6abd884231cb44a4da2cbd6130713f5538b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfa53c9ffec3fce6cadb43bab967ddc0b8f6e447ae279f451f2a678d5286d7b70ca98cdfe263f191949442b5820c96af7d63a2a2c68b0188c36d6a760ca7cd4f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:47.324587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:47.324931) ========= 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=4300f881736b422476174874000001bc-1464431840.391827-1565704662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:47.407824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:57:47.408176) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:57:47.408494) ========= ========= Total master_lag: 0.17 =========