builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1463170032.56 results: success (0) buildid: 20160513103035 builduid: 6cd47609dea0442ebba730de9a3dd25f revision: ac470f026c69f90c82798f15dbf9d538fc99b68e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:12.558037) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:12.558559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:12.558849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:12.694884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:12.695301) ========= 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=33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 13:07:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 333K=0.04s 2016-05-13 13:07:14 (333 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.238004 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:12.972629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:12.972951) ========= 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=33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014376 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:13.065801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:13.066216) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ac470f026c69f90c82798f15dbf9d538fc99b68e --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 ac470f026c69f90c82798f15dbf9d538fc99b68e --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=33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 13:07:14,728 truncating revision to first 12 chars 2016-05-13 13:07:14,728 Setting DEBUG logging. 2016-05-13 13:07:14,728 attempt 1/10 2016-05-13 13:07:14,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ac470f026c69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 13:07:15,040 unpacking tar archive at: mozilla-aurora-ac470f026c69/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604012 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:13.694805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:13.695146) ========= script_repo_revision: ac470f026c69f90c82798f15dbf9d538fc99b68e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:13.695600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:13.695888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:07:13.729619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-13 13:07:13.729944) ========= /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=33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:15 INFO - MultiFileLogger online at 20160513 13:07:15 in /builds/slave/test 13:07:15 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 13:07:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:15 INFO - {'append_to_log': False, 13:07:15 INFO - 'base_work_dir': '/builds/slave/test', 13:07:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:07:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:15 INFO - 'branch': 'Mozilla-Aurora', 13:07:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:15 INFO - 'config_files': ('talos/linux_config.py',), 13:07:15 INFO - 'default_actions': ('clobber', 13:07:15 INFO - 'read-buildbot-config', 13:07:15 INFO - 'download-and-extract', 13:07:15 INFO - 'populate-webroot', 13:07:15 INFO - 'create-virtualenv', 13:07:15 INFO - 'install', 13:07:15 INFO - 'run-tests'), 13:07:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:15 INFO - 'download_minidump_stackwalk': True, 13:07:15 INFO - 'download_symbols': 'ondemand', 13:07:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:15 INFO - 'installer_path': 'installer.exe', 13:07:15 INFO - 'log_level': 'info', 13:07:15 INFO - 'log_name': 'talos', 13:07:15 INFO - 'log_to_console': True, 13:07:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:15 INFO - 'opt_config_files': (), 13:07:15 INFO - 'pip_index': False, 13:07:15 INFO - 'sps_profile': False, 13:07:15 INFO - 'sps_profile_interval': 0, 13:07:15 INFO - 'suite': 'dromaeojs-e10s', 13:07:15 INFO - 'system_bits': '32', 13:07:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:15 INFO - 'title': 'talos-linux64-ix-063', 13:07:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:15 INFO - 'use_talos_json': True, 13:07:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:15 INFO - 'work_dir': 'build'} 13:07:15 INFO - ##### 13:07:15 INFO - ##### Running clobber step. 13:07:15 INFO - ##### 13:07:15 INFO - Running pre-action listener: _resource_record_pre_action 13:07:15 INFO - Running main action method: clobber 13:07:15 INFO - rmtree: /builds/slave/test/build 13:07:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:16 INFO - Running post-action listener: _resource_record_post_action 13:07:16 INFO - ##### 13:07:16 INFO - ##### Running read-buildbot-config step. 13:07:16 INFO - ##### 13:07:16 INFO - Running pre-action listener: _resource_record_pre_action 13:07:16 INFO - Running main action method: read_buildbot_config 13:07:16 INFO - Using buildbot properties: 13:07:16 INFO - { 13:07:16 INFO - "project": "", 13:07:16 INFO - "product": "firefox", 13:07:16 INFO - "script_repo_revision": "production", 13:07:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:07:16 INFO - "repository": "", 13:07:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:07:16 INFO - "buildid": "20160513103035", 13:07:16 INFO - "pgo_build": "True", 13:07:16 INFO - "basedir": "/builds/slave/test", 13:07:16 INFO - "buildnumber": 266, 13:07:16 INFO - "slavename": "talos-linux64-ix-063", 13:07:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:07:16 INFO - "platform": "ubuntu64_hw", 13:07:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:07:16 INFO - "branch": "mozilla-aurora", 13:07:16 INFO - "repo_path": "releases/mozilla-aurora", 13:07:16 INFO - "revision": "ac470f026c69f90c82798f15dbf9d538fc99b68e", 13:07:16 INFO - "stage_platform": "linux64-pgo", 13:07:16 INFO - "builduid": "6cd47609dea0442ebba730de9a3dd25f", 13:07:16 INFO - "slavebuilddir": "test" 13:07:16 INFO - } 13:07:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:07:16 INFO - Running post-action listener: _resource_record_post_action 13:07:16 INFO - ##### 13:07:16 INFO - ##### Running download-and-extract step. 13:07:16 INFO - ##### 13:07:16 INFO - Running pre-action listener: _resource_record_pre_action 13:07:16 INFO - Running main action method: download_and_extract 13:07:16 INFO - mkdir: /builds/slave/test/build/tests 13:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:16 INFO - https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:18 INFO - Downloaded 1361 bytes. 13:07:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:07:18 INFO - Using the following test package requirements: 13:07:18 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:07:18 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:18 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:07:18 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'jsshell-linux-x86_64.zip'], 13:07:18 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:18 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:07:18 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:07:18 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:07:18 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:18 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:07:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:18 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:18 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')]} 13:07:18 INFO - https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:07:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:07:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:23 INFO - Downloaded 23799980 bytes. 13:07:23 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'] 13:07:23 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 13:07:24 INFO - Return code: 0 13:07:24 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 13:07: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')]} 13:07:24 INFO - https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:07:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:07:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:25 INFO - Downloaded 23799980 bytes. 13:07: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'] 13:07: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 13:07:27 INFO - Return code: 0 13:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:27 INFO - https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:29 INFO - Downloaded 10840145 bytes. 13:07: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'] 13:07: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 13:07:29 INFO - Return code: 0 13:07: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')]} 13:07:29 INFO - https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwMB36YQR6K3uUB5l3-FCA/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 13:07:33 INFO - Downloaded 62720398 bytes. 13:07:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:07:33 INFO - mkdir: /builds/slave/test/properties 13:07:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:33 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:33 INFO - Contents: 13:07:33 INFO - build_url:https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:07:34 INFO - Running post-action listener: _resource_record_post_action 13:07:34 INFO - Running post-action listener: set_extra_try_arguments 13:07:34 INFO - ##### 13:07:34 INFO - ##### Running populate-webroot step. 13:07:34 INFO - ##### 13:07:34 INFO - Running pre-action listener: _resource_record_pre_action 13:07:34 INFO - Running main action method: populate_webroot 13:07:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:34 INFO - '--tppagecycles', 13:07:34 INFO - '7'], 13:07:34 INFO - 'tests': ['tsvgm']}}, 13:07:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['damp', 'tps']}, 13:07:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'tests': ['damp', 'tps']}, 13:07:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['dromaeo_dom']}, 13:07:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['a11yr', 13:07:34 INFO - 'ts_paint', 13:07:34 INFO - 'tpaint', 13:07:34 INFO - 'sessionrestore', 13:07:34 INFO - 'sessionrestore_no_auto_restore', 13:07:34 INFO - 'tabpaint']}, 13:07:34 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:34 INFO - 'ts_paint', 13:07:34 INFO - 'tpaint', 13:07:34 INFO - 'sessionrestore', 13:07:34 INFO - 'sessionrestore_no_auto_restore', 13:07:34 INFO - 'tabpaint']}, 13:07:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:34 INFO - 'ts_paint', 13:07:34 INFO - 'tpaint', 13:07:34 INFO - 'sessionrestore', 13:07:34 INFO - 'sessionrestore_no_auto_restore', 13:07:34 INFO - 'tabpaint']}, 13:07:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:34 INFO - 'ts_paint', 13:07:34 INFO - 'tpaint', 13:07:34 INFO - 'sessionrestore', 13:07:34 INFO - 'sessionrestore_no_auto_restore', 13:07:34 INFO - 'tabpaint']}, 13:07:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['a11yr', 13:07:34 INFO - 'ts_paint', 13:07:34 INFO - 'tpaint', 13:07:34 INFO - 'sessionrestore', 13:07:34 INFO - 'sessionrestore_no_auto_restore', 13:07:34 INFO - 'tabpaint']}, 13:07:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['a11yr', 13:07:34 INFO - 'ts_paint', 13:07:34 INFO - 'tpaint', 13:07:34 INFO - 'sessionrestore', 13:07:34 INFO - 'sessionrestore_no_auto_restore', 13:07:34 INFO - 'tabpaint']}, 13:07:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['tsvgx', 13:07:34 INFO - 'tsvgr_opacity', 13:07:34 INFO - 'tart', 13:07:34 INFO - 'tscrollx', 13:07:34 INFO - 'cart']}, 13:07:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:34 INFO - 'tsvgr_opacity', 13:07:34 INFO - 'tart', 13:07:34 INFO - 'tscrollx', 13:07:34 INFO - 'cart']}, 13:07:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'talos_options': ['--disable-e10s'], 13:07:34 INFO - 'tests': ['tp5o']}, 13:07:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'tests': ['tp5o']}, 13:07:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'talos_options': ['--disable-e10s', 13:07:34 INFO - '--xperf_path', 13:07:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:34 INFO - 'tests': ['tp5n']}, 13:07:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:34 INFO - 'talos_options': ['--xperf_path', 13:07:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:34 INFO - 'tests': ['tp5n']}}, 13:07:34 INFO - 'talos.zip': {'path': '', 13:07:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:34 INFO - Running post-action listener: _resource_record_post_action 13:07:34 INFO - ##### 13:07:34 INFO - ##### Running create-virtualenv step. 13:07:34 INFO - ##### 13:07:34 INFO - Running pre-action listener: _resource_record_pre_action 13:07:34 INFO - Running main action method: create_virtualenv 13:07:34 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:34 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 13:07:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:34 INFO - Using real prefix '/usr' 13:07:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:35 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:37 INFO - Installing pip.................done. 13:07:37 INFO - Return code: 0 13:07:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:07:37 INFO - Using env: {'DISPLAY': ':0', 13:07:37 INFO - 'HOME': '/home/cltbld', 13:07:37 INFO - 'LANG': 'en_US.UTF-8', 13:07:37 INFO - 'LANGUAGE': 'en_US:en', 13:07:37 INFO - 'LOGNAME': 'cltbld', 13:07:37 INFO - 'MAIL': '/var/mail/cltbld', 13:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:37 INFO - 'MOZ_NO_REMOTE': '1', 13:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:37 INFO - 'NO_EM_RESTART': '1', 13:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:37 INFO - 'PWD': '/builds/slave/test', 13:07:37 INFO - 'SHELL': '/bin/bash', 13:07:37 INFO - 'SHLVL': '1', 13:07:37 INFO - 'TERM': 'linux', 13:07:37 INFO - 'TMOUT': '86400', 13:07:37 INFO - 'USER': 'cltbld', 13:07:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:37 INFO - '_': '/tools/buildbot/bin/python'} 13:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:37 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 13:07:37 INFO - Cleaning up... 13:07:37 INFO - Return code: 0 13:07:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:07:37 INFO - Using env: {'DISPLAY': ':0', 13:07:37 INFO - 'HOME': '/home/cltbld', 13:07:37 INFO - 'LANG': 'en_US.UTF-8', 13:07:37 INFO - 'LANGUAGE': 'en_US:en', 13:07:37 INFO - 'LOGNAME': 'cltbld', 13:07:37 INFO - 'MAIL': '/var/mail/cltbld', 13:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:37 INFO - 'MOZ_NO_REMOTE': '1', 13:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:37 INFO - 'NO_EM_RESTART': '1', 13:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:37 INFO - 'PWD': '/builds/slave/test', 13:07:37 INFO - 'SHELL': '/bin/bash', 13:07:37 INFO - 'SHLVL': '1', 13:07:37 INFO - 'TERM': 'linux', 13:07:37 INFO - 'TMOUT': '86400', 13:07:37 INFO - 'USER': 'cltbld', 13:07:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:37 INFO - '_': '/tools/buildbot/bin/python'} 13:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:37 INFO - Downloading/unpacking psutil>=0.7.1 13:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:40 INFO - Installing collected packages: psutil 13:07:40 INFO - Running setup.py install for psutil 13:07:40 INFO - building 'psutil._psutil_linux' extension 13:07:40 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 13:07:41 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 13:07:41 INFO - building 'psutil._psutil_posix' extension 13:07:41 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 13:07:41 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 13:07:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:41 INFO - Successfully installed psutil 13:07:41 INFO - Cleaning up... 13:07:41 INFO - Return code: 0 13:07:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 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 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:41 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 13:07:41 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 13:07:41 INFO - Using env: {'DISPLAY': ':0', 13:07:41 INFO - 'HOME': '/home/cltbld', 13:07:41 INFO - 'LANG': 'en_US.UTF-8', 13:07:41 INFO - 'LANGUAGE': 'en_US:en', 13:07:41 INFO - 'LOGNAME': 'cltbld', 13:07:41 INFO - 'MAIL': '/var/mail/cltbld', 13:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:41 INFO - 'MOZ_NO_REMOTE': '1', 13:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:41 INFO - 'NO_EM_RESTART': '1', 13:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:41 INFO - 'PWD': '/builds/slave/test', 13:07:41 INFO - 'SHELL': '/bin/bash', 13:07:41 INFO - 'SHLVL': '1', 13:07:41 INFO - 'TERM': 'linux', 13:07:41 INFO - 'TMOUT': '86400', 13:07:41 INFO - 'USER': 'cltbld', 13:07:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:41 INFO - '_': '/tools/buildbot/bin/python'} 13:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:07:41 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 13:07:41 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 13:07:41 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 13:07:41 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 13:07:41 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 13:07:41 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 13:07:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:07:44 INFO - Installing collected packages: mozsystemmonitor 13:07:44 INFO - Running setup.py install for mozsystemmonitor 13:07:44 INFO - Successfully installed mozsystemmonitor 13:07:44 INFO - Cleaning up... 13:07:44 INFO - Return code: 0 13:07:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:44 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 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:44 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 13:07:44 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 13:07:44 INFO - Using env: {'DISPLAY': ':0', 13:07:44 INFO - 'HOME': '/home/cltbld', 13:07:44 INFO - 'LANG': 'en_US.UTF-8', 13:07:44 INFO - 'LANGUAGE': 'en_US:en', 13:07:44 INFO - 'LOGNAME': 'cltbld', 13:07:44 INFO - 'MAIL': '/var/mail/cltbld', 13:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:44 INFO - 'MOZ_NO_REMOTE': '1', 13:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:44 INFO - 'NO_EM_RESTART': '1', 13:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:44 INFO - 'PWD': '/builds/slave/test', 13:07:44 INFO - 'SHELL': '/bin/bash', 13:07:44 INFO - 'SHLVL': '1', 13:07:44 INFO - 'TERM': 'linux', 13:07:44 INFO - 'TMOUT': '86400', 13:07:44 INFO - 'USER': 'cltbld', 13:07:44 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:44 INFO - '_': '/tools/buildbot/bin/python'} 13:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:44 INFO - Downloading/unpacking blobuploader==1.2.4 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:46 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 INFO - Downloading docopt-0.6.1.tar.gz 13:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:47 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:47 INFO - Running setup.py install for blobuploader 13:07:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:47 INFO - Running setup.py install for requests 13:07:47 INFO - Running setup.py install for docopt 13:07:47 INFO - Successfully installed blobuploader requests docopt 13:07:47 INFO - Cleaning up... 13:07:48 INFO - Return code: 0 13:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:48 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 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:48 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 13:07:48 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 13:07:48 INFO - Using env: {'DISPLAY': ':0', 13:07:48 INFO - 'HOME': '/home/cltbld', 13:07:48 INFO - 'LANG': 'en_US.UTF-8', 13:07:48 INFO - 'LANGUAGE': 'en_US:en', 13:07:48 INFO - 'LOGNAME': 'cltbld', 13:07:48 INFO - 'MAIL': '/var/mail/cltbld', 13:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:48 INFO - 'MOZ_NO_REMOTE': '1', 13:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:48 INFO - 'NO_EM_RESTART': '1', 13:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:48 INFO - 'PWD': '/builds/slave/test', 13:07:48 INFO - 'SHELL': '/bin/bash', 13:07:48 INFO - 'SHLVL': '1', 13:07:48 INFO - 'TERM': 'linux', 13:07:48 INFO - 'TMOUT': '86400', 13:07:48 INFO - 'USER': 'cltbld', 13:07:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:48 INFO - '_': '/tools/buildbot/bin/python'} 13:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:48 INFO - Running setup.py (path:/tmp/pip-mOdT47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:48 INFO - Running setup.py (path:/tmp/pip-y6itcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:48 INFO - Running setup.py (path:/tmp/pip-RLZjh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:48 INFO - Running setup.py (path:/tmp/pip-HHozhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:48 INFO - Running setup.py (path:/tmp/pip-zpkSGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:48 INFO - Running setup.py (path:/tmp/pip-D1AaJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:48 INFO - Running setup.py (path:/tmp/pip-4fiq90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:48 INFO - Running setup.py (path:/tmp/pip-DqhBDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:48 INFO - Running setup.py (path:/tmp/pip-y5YKIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:48 INFO - Running setup.py (path:/tmp/pip-c52Y8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:48 INFO - Running setup.py (path:/tmp/pip-VedPhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:49 INFO - Running setup.py (path:/tmp/pip-R2S36i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:49 INFO - Running setup.py (path:/tmp/pip-HGgchv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:49 INFO - Running setup.py (path:/tmp/pip-dkVZ44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:49 INFO - Running setup.py (path:/tmp/pip-hd7B0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:49 INFO - Running setup.py (path:/tmp/pip-Jp1uZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:49 INFO - Running setup.py (path:/tmp/pip-E7HiDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:49 INFO - Running setup.py install for manifestparser 13:07:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:49 INFO - Running setup.py install for mozcrash 13:07:49 INFO - Running setup.py install for mozdebug 13:07:49 INFO - Running setup.py install for mozdevice 13:07:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:07:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:07:49 INFO - Running setup.py install for mozfile 13:07:49 INFO - Running setup.py install for mozhttpd 13:07:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Running setup.py install for mozinfo 13:07:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Running setup.py install for mozInstall 13:07:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Running setup.py install for mozleak 13:07:50 INFO - Running setup.py install for mozlog 13:07:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Running setup.py install for moznetwork 13:07:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Running setup.py install for mozprocess 13:07:50 INFO - Running setup.py install for mozprofile 13:07:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Running setup.py install for mozrunner 13:07:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:07:50 INFO - Running setup.py install for mozscreenshot 13:07:51 INFO - Running setup.py install for moztest 13:07:51 INFO - Running setup.py install for mozversion 13:07:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:07:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:07:51 INFO - Cleaning up... 13:07:51 INFO - Return code: 0 13:07:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:51 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 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:51 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 13:07:51 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 13:07:51 INFO - Using env: {'DISPLAY': ':0', 13:07:51 INFO - 'HOME': '/home/cltbld', 13:07:51 INFO - 'LANG': 'en_US.UTF-8', 13:07:51 INFO - 'LANGUAGE': 'en_US:en', 13:07:51 INFO - 'LOGNAME': 'cltbld', 13:07:51 INFO - 'MAIL': '/var/mail/cltbld', 13:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:51 INFO - 'MOZ_NO_REMOTE': '1', 13:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:51 INFO - 'NO_EM_RESTART': '1', 13:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:51 INFO - 'PWD': '/builds/slave/test', 13:07:51 INFO - 'SHELL': '/bin/bash', 13:07:51 INFO - 'SHLVL': '1', 13:07:51 INFO - 'TERM': 'linux', 13:07:51 INFO - 'TMOUT': '86400', 13:07:51 INFO - 'USER': 'cltbld', 13:07:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:51 INFO - '_': '/tools/buildbot/bin/python'} 13:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:51 INFO - Running setup.py (path:/tmp/pip-3mlUgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:51 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)) 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:51 INFO - Running setup.py (path:/tmp/pip-CIIghs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:51 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)) 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:51 INFO - Running setup.py (path:/tmp/pip-HbFpzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:51 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)) 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:51 INFO - Running setup.py (path:/tmp/pip-thfOsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:51 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)) 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:51 INFO - Running setup.py (path:/tmp/pip-DC4kKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:51 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)) 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:51 INFO - Running setup.py (path:/tmp/pip-wm81WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:51 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)) 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:51 INFO - Running setup.py (path:/tmp/pip-pIObMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:51 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)) 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:51 INFO - Running setup.py (path:/tmp/pip-C4TZZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:52 INFO - Running setup.py (path:/tmp/pip-v8SpDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:52 INFO - Running setup.py (path:/tmp/pip-tPruhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:52 INFO - Running setup.py (path:/tmp/pip-svn4qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:52 INFO - Running setup.py (path:/tmp/pip-4YYR3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:52 INFO - Running setup.py (path:/tmp/pip-Uftf0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:52 INFO - Running setup.py (path:/tmp/pip-rEJ6Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:52 INFO - Running setup.py (path:/tmp/pip-7tc9Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:52 INFO - Running setup.py (path:/tmp/pip-Bl3P0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:52 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)) 13:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:52 INFO - Running setup.py (path:/tmp/pip-EUAjcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:54 INFO - Downloading blessings-1.6.tar.gz 13:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:07:54 INFO - Installing collected packages: blessings 13:07:54 INFO - Running setup.py install for blessings 13:07:54 INFO - Successfully installed blessings 13:07:54 INFO - Cleaning up... 13:07:54 INFO - Return code: 0 13:07:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:55 INFO - Reading from file tmpfile_stdout 13:07:55 INFO - Current package versions: 13:07:55 INFO - argparse == 1.2.1 13:07:55 INFO - blessings == 1.6 13:07:55 INFO - blobuploader == 1.2.4 13:07:55 INFO - docopt == 0.6.1 13:07:55 INFO - manifestparser == 1.1 13:07:55 INFO - mozInstall == 1.12 13:07:55 INFO - mozcrash == 0.17 13:07:55 INFO - mozdebug == 0.1 13:07:55 INFO - mozdevice == 0.48 13:07:55 INFO - mozfile == 1.2 13:07:55 INFO - mozhttpd == 0.7 13:07:55 INFO - mozinfo == 0.9 13:07:55 INFO - mozleak == 0.1 13:07:55 INFO - mozlog == 3.1 13:07:55 INFO - moznetwork == 0.27 13:07:55 INFO - mozprocess == 0.22 13:07:55 INFO - mozprofile == 0.28 13:07:55 INFO - mozrunner == 6.11 13:07:55 INFO - mozscreenshot == 0.1 13:07:55 INFO - mozsystemmonitor == 0.0 13:07:55 INFO - moztest == 0.7 13:07:55 INFO - mozversion == 1.4 13:07:55 INFO - psutil == 3.1.1 13:07:55 INFO - requests == 1.2.3 13:07:55 INFO - wsgiref == 0.1.2 13:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 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 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:55 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 13:07:55 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 13:07:55 INFO - Using env: {'DISPLAY': ':0', 13:07:55 INFO - 'HOME': '/home/cltbld', 13:07:55 INFO - 'LANG': 'en_US.UTF-8', 13:07:55 INFO - 'LANGUAGE': 'en_US:en', 13:07:55 INFO - 'LOGNAME': 'cltbld', 13:07:55 INFO - 'MAIL': '/var/mail/cltbld', 13:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:55 INFO - 'MOZ_NO_REMOTE': '1', 13:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:55 INFO - 'NO_EM_RESTART': '1', 13:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:55 INFO - 'PWD': '/builds/slave/test', 13:07:55 INFO - 'SHELL': '/bin/bash', 13:07:55 INFO - 'SHLVL': '1', 13:07:55 INFO - 'TERM': 'linux', 13:07:55 INFO - 'TMOUT': '86400', 13:07:55 INFO - 'USER': 'cltbld', 13:07:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:55 INFO - '_': '/tools/buildbot/bin/python'} 13:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 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)) 13:07:55 INFO - Cleaning up... 13:07:55 INFO - Return code: 0 13:07:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:07:55 INFO - Using env: {'DISPLAY': ':0', 13:07:55 INFO - 'HOME': '/home/cltbld', 13:07:55 INFO - 'LANG': 'en_US.UTF-8', 13:07:55 INFO - 'LANGUAGE': 'en_US:en', 13:07:55 INFO - 'LOGNAME': 'cltbld', 13:07:55 INFO - 'MAIL': '/var/mail/cltbld', 13:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:55 INFO - 'MOZ_NO_REMOTE': '1', 13:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:55 INFO - 'NO_EM_RESTART': '1', 13:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:55 INFO - 'PWD': '/builds/slave/test', 13:07:55 INFO - 'SHELL': '/bin/bash', 13:07:55 INFO - 'SHLVL': '1', 13:07:55 INFO - 'TERM': 'linux', 13:07:55 INFO - 'TMOUT': '86400', 13:07:55 INFO - 'USER': 'cltbld', 13:07:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:55 INFO - '_': '/tools/buildbot/bin/python'} 13:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:55 INFO - Downloading/unpacking jsonschema 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:57 INFO - Downloading/unpacking functools32 (from jsonschema) 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:57 INFO - warning: no files found matching '*.txt' 13:07:57 INFO - no previously-included directories found matching 'build' 13:07:57 INFO - no previously-included directories found matching 'dist' 13:07:57 INFO - no previously-included directories found matching '.git*' 13:07:57 INFO - Installing collected packages: jsonschema, functools32 13:07:57 INFO - Running setup.py install for functools32 13:07:57 INFO - warning: no files found matching '*.txt' 13:07:57 INFO - no previously-included directories found matching 'build' 13:07:57 INFO - no previously-included directories found matching 'dist' 13:07:57 INFO - no previously-included directories found matching '.git*' 13:07:57 INFO - Successfully installed jsonschema functools32 13:07:57 INFO - Cleaning up... 13:07:57 INFO - Return code: 0 13:07:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:57 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 0x7fd857eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, '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': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', '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 13:07:57 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 13:07:57 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 13:07:57 INFO - Using env: {'DISPLAY': ':0', 13:07:57 INFO - 'HOME': '/home/cltbld', 13:07:57 INFO - 'LANG': 'en_US.UTF-8', 13:07:57 INFO - 'LANGUAGE': 'en_US:en', 13:07:57 INFO - 'LOGNAME': 'cltbld', 13:07:57 INFO - 'MAIL': '/var/mail/cltbld', 13:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:57 INFO - 'MOZ_NO_REMOTE': '1', 13:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:57 INFO - 'NO_EM_RESTART': '1', 13:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:57 INFO - 'PWD': '/builds/slave/test', 13:07:57 INFO - 'SHELL': '/bin/bash', 13:07:57 INFO - 'SHLVL': '1', 13:07:57 INFO - 'TERM': 'linux', 13:07:57 INFO - 'TMOUT': '86400', 13:07:57 INFO - 'USER': 'cltbld', 13:07:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:57 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 INFO - Downloading/unpacking flake8 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:08:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:08:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 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 13:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:00 INFO - no previously-included directories found matching 'docs/_build' 13:08:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:08:00 INFO - Running setup.py install for pep8 13:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:00 INFO - no previously-included directories found matching 'docs/_build' 13:08:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:08:00 INFO - Cleaning up... 13:08:01 INFO - Return code: 0 13:08:01 INFO - Running post-action listener: _resource_record_post_action 13:08:01 INFO - Running post-action listener: _start_resource_monitoring 13:08:01 INFO - Starting resource monitoring. 13:08:01 INFO - ##### 13:08:01 INFO - ##### Running install step. 13:08:01 INFO - ##### 13:08:01 INFO - Running pre-action listener: _resource_record_pre_action 13:08:01 INFO - Running main action method: install 13:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:01 INFO - Reading from file tmpfile_stdout 13:08:01 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:01 INFO - Reading from file tmpfile_stdout 13:08:01 INFO - Output received: 13:08:01 INFO - Usage: mozinstall [options] installer 13:08:01 INFO - Options: 13:08:01 INFO - -h, --help show this help message and exit 13:08:01 INFO - -d DEST, --destination=DEST 13:08:01 INFO - Directory to install application into. [default: 13:08:01 INFO - "/builds/slave/test"] 13:08:01 INFO - --app=APP Application being installed. [default: firefox] 13:08:01 INFO - mkdir: /builds/slave/test/build/application 13:08:01 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'] 13:08:01 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 13:08:16 INFO - Reading from file tmpfile_stdout 13:08:16 INFO - Output received: 13:08:16 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:16 INFO - Running post-action listener: _resource_record_post_action 13:08:16 INFO - ##### 13:08:16 INFO - ##### Running run-tests step. 13:08:16 INFO - ##### 13:08:16 INFO - Running pre-action listener: _resource_record_pre_action 13:08:16 INFO - Running main action method: run_tests 13:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:16 INFO - Python 2.7.3 13:08:16 INFO - Return code: 0 13:08:16 INFO - grabbing minidump binary from tooltool 13:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:16 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 0x125f410>, '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 0x1260310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12607a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:16 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 13:08:16 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 13:08:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:17 INFO - Return code: 0 13:08:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:08:17 INFO - Return code: 0 13:08:17 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/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:08:17 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/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 13:08:17 INFO - Using env: {'DISPLAY': ':0', 13:08:17 INFO - 'HOME': '/home/cltbld', 13:08:17 INFO - 'LANG': 'en_US.UTF-8', 13:08:17 INFO - 'LANGUAGE': 'en_US:en', 13:08:17 INFO - 'LOGNAME': 'cltbld', 13:08:17 INFO - 'MAIL': '/var/mail/cltbld', 13:08:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:17 INFO - 'MOZ_NO_REMOTE': '1', 13:08:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:17 INFO - 'NO_EM_RESTART': '1', 13:08:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:17 INFO - 'PWD': '/builds/slave/test', 13:08:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:17 INFO - 'SHELL': '/bin/bash', 13:08:17 INFO - 'SHLVL': '1', 13:08:17 INFO - 'TERM': 'linux', 13:08:17 INFO - 'TMOUT': '86400', 13:08:17 INFO - 'USER': 'cltbld', 13:08:17 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458', 13:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:17 INFO - '_': '/tools/buildbot/bin/python'} 13:08:17 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/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:08:18 INFO - mozversion application_buildid: 20160513103035 13:08:18 INFO - mozversion application_changeset: ac470f026c69f90c82798f15dbf9d538fc99b68e 13:08:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:08:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:18 INFO - mozversion application_name: Firefox 13:08:18 INFO - mozversion application_remotingname: firefox-dev 13:08:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:08:18 INFO - mozversion application_vendor: Mozilla 13:08:18 INFO - mozversion application_version: 48.0a2 13:08:18 INFO - mozversion platform_buildid: 20160513103035 13:08:18 INFO - mozversion platform_changeset: ac470f026c69f90c82798f15dbf9d538fc99b68e 13:08:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:08:18 INFO - mozversion platform_version: 48.0a2 13:08:18 INFO - using testdate: 1463170098 13:08:18 INFO - actual date: 1463170098 13:08:18 INFO - starting webserver on 'localhost:55188' 13:08:18 INFO - SUITE-START | Running 2 tests 13:08:18 INFO - TEST-START | dromaeo_css 13:08:18 INFO - operating with platform_type : linux_ 13:08:18 INFO - Initialising browser for dromaeo_css test... 13:08:18 INFO - TEST-INFO | started process 16894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKHYCk_/profile http://localhost:55188/getInfo.html) 13:08:22 INFO - PROCESS | 16894 | 13:08:22 INFO - PROCESS | 16894 | (process:16972): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:08:23 INFO - PROCESS | 16894 | __metrics Screen width/height:1600/1200 13:08:23 INFO - PROCESS | 16894 | colorDepth:24 13:08:23 INFO - PROCESS | 16894 | Browser inner width/height: 1024/697 13:08:23 INFO - PROCESS | 16894 | __metrics 13:08:23 ERROR - PROCESS | 16894 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 13:08:24 INFO - TEST-INFO | 16894: exit 0 13:08:24 INFO - Browser initialized. 13:08:24 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:24 INFO - TEST-INFO | started process 17023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKHYCk_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:26 INFO - PROCESS | 17023 | 13:08:26 INFO - PROCESS | 17023 | (process:17097): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:08:36 INFO - PROCESS | 17023 | RSS: Main: 152027136 13:08:36 INFO - PROCESS | 17023 | 13:09:26 INFO - PROCESS | 17023 | 1463170166190 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] 13:11:33 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:55188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55188/tests/dromaeo/cssquery-ext.html) 13:11:34 INFO - PROCESS | 17023 | RSS: Main: 155774976 13:11:34 INFO - PROCESS | 17023 | 13:14:36 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:55188/tests/dromaeo/cssquery-ext.html (next: http://localhost:55188/tests/dromaeo/cssquery-jquery.html) 13:14:37 INFO - PROCESS | 17023 | RSS: Main: 153522176 13:14:37 INFO - PROCESS | 17023 | 13:17:39 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:55188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55188/tests/dromaeo/cssquery-mootools.html) 13:17:39 INFO - PROCESS | 17023 | RSS: Main: 153231360 13:17:39 INFO - PROCESS | 17023 | 13:20:41 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:55188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55188/tests/dromaeo/cssquery-prototype.html) 13:20:42 INFO - PROCESS | 17023 | RSS: Main: 152854528 13:20:42 INFO - PROCESS | 17023 | 13:23:44 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:55188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55188/tests/dromaeo/cssquery-yui.html) 13:23:45 INFO - PROCESS | 17023 | RSS: Main: 154439680 13:23:45 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:55188/tests/dromaeo/cssquery-yui.html (next: http://localhost:55188/tests/dromaeo/cssquery-dojo.html) 13:26:47 INFO - PROCESS | 17023 | RSS: Main: 155840512 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | __start_tp_report 13:26:47 INFO - PROCESS | 17023 | _x_x_mozilla_page_load 13:26:47 INFO - PROCESS | 17023 | _x_x_mozilla_page_load_details 13:26:47 INFO - PROCESS | 17023 | |i|pagename|runs| 13:26:47 INFO - PROCESS | 17023 | |0;dojo.html;3293.1108600677812;3355.379254837855;3396.5414669019674;3408.863645454182;3427.8800241991535;5635.83092507225;5637.3235211774645;5697.202391665171;5705.172749951254;5706.087026075828;5660;5669.688167150805;5682.6306290091115;5684.261046064006;5692.9146062809095;5105.336306280178;5144.691318520882;5173.094708426029;5212.921806172911;5244.8688782780355;5047.318611987372;5151.74241287936;5289.947100529003;5294.258803767457;5301.204819277101;5037.395512538501;5190.4290528042075;5194.584433245332;5267.315249017623;5284.735763211843;5143.742812859361;5146.897062058775;5162.303089082982;5175.404828444702;5194.039102766001;4880.536349046871;5013.273075404082;5074.985002999378;5125.974370128126;5152.690838549699;5455.972720136414;5488.506034456878;5506.256655351516;5541.944580554183;5566.86082847928;5980.34216236218;6011.879762404771;6014.609050411753;6020.337762846083;6027.367126451703;5890.381509941437;5992.310884248323;6068.393160683941;6074.088886666991;6079.118527813486;5559.11054231321;5603.10350343943;5604.103343465026;5637.069883469223;5666.575006874501;6138.1713468681155;6194.752209911553;6205.503559715212;6206.100115483229;6207.534434917399;5893.410658934158;5927.614705044159;5956.225690660186;5956.821295361146;5967.5524335675;6006.009008513546;6010.759569617167;6039.063945088518;6050.667213303311;6085.361037091042;5994.490468310155;5999.670018149044;6006.939930600638;6007.699615019232;6009.789657361971;5828.825135245865;5909.936211481974;5931.6441013539325;6008.699565021819;6011.939880601138;4571.657125715585;4577.748223847654;4584.61030812378;4592.609628181642;4602;4094.815733292009;4105.938410923838;4115.259253334429;4156.044109854751;4163.12574359388;5707.885842283131;5720.628159169641;5757.021306377926;5797.304323481209;5837.211976383134;5951.702414879239;5975.07386355107;5999.310079340845;5999.850003749942;6018.277806663228;5736.598438109292;5752.913706294409;5760.74076666551;5761.827145185567;5791.391903850119;5092.949070509321;5206.036883176549;5242.711650859239;5249.868753281198;5259.263703081571;6189.96905015472;6196.442320191204;6205.937940620626;6213.813585592439;6218.657973811393;5933.584649074696;5967.731452084753;5984.162217289496;5989.550783691154;5999.970000149971;6248.187735594343;6266.404691554295;6309.085182648582;6309.936900630935;6319.210098737658;5936.673482958478;6004.699765011819;6020.39796020412;6026.849328766816;6060.757569697339;5869.383714709894;5981.970090149522;6105.786297479567;6114.2357205349335;6136;5998.820035398945;5999.1601175836295;6000.759969601167;6012.549058820518;6037.034074548052;5892.145638882424;5933.465988061095;5968.045112781934;5969.253843269591;5971.343152253336;5650.434956504481;5785.56608254391;5794.971025144847;5849.707514624337;5859.677717725566;5669.574781891292;5751.252337196138;5769.826905192851;5811.912821307599;5857.5313974881055;5594.188842617717;5604.663720176803;5640.294963129609;5644.294463192101;5656.915146272891 13:26:47 INFO - PROCESS | 17023 | |1;ext.html;611.6819253987926;666.6033709942584;667.4993754683987;684.0867441964976;685.0990946904823;39235;40150.59849401505;40335.596644033554;40336.193276134494;40372;43969.78015109928;44402.77798611011;44519.77740111303;44647.55352446475;44954.77522612391;8892.333075019367;9042.502662353569;9138.497382643953;9143.817123657524;9153.313501487382;8827.558622068904;8936.240419564312;8963;9167.44995300284;9223.446593204395;9157;9174.220191283748;9192.954035229814;9202.907970920272;9217.446953182796;9160.267178625727;9179.265658747318;9181.67864124759;9194.172524472797;9228.723138305795;9108.407953483002;9173.403728757676;9246.907530924673;9253.907460925371;9263.675771348038;43973.78013109946;44178;44327;44474;44721;4017.9196416071513;4104.343305071175;4201.936970945439;4524.660650451229;4565.178267911774;34142.6585734142;34186.658133418845;34336;34412.483812742576;35412.11469713252;4613.8154473821005;4624.35259063728;4631.976840115778;4651.301440303685;4653.255479123324;312375.99999999773;316245;316844;317968;318850;61023.694881525305;61663.38336616576;61968;61971.38028619656;62107.378926210156;70348.29651703418;71576.284237158;71859.64070179616;72399;72486;19601.509962251057;19718.70421943672;19838.107285172202;19843.60312793736;19921.302754403816;15245.466408675644;15280.159591222367;15403.537893863202;15417.152056636993;15425;19949.202031918852;20144.798552014585;20358.083886225155;20388.898055509922;21146.577068458544;7691.692891752858;7853.41099417546;7858.882116768253;7900.920990790133;8044;1116.9273997190157;1126.4818183635455;1164.2897832322276;1167.235460773195;1167.416291854073;32113.67886321107;32157.678423215937;33004.66995330016;33212.3357532848;33330.33339333248;1133.54091592905;1196.5512932650256;1230.3479156047308;1300.9869901301056;1326.9336533173496;17307.740383894252;17751.55621109457;17771.378001769877;17940.461786146436;18010.819891801177;466284;628550;633529;652401;841764;56448.71775641095;57582.424175757704;57836.42163578395;57842.8431431369;57926;1413.4134334251376;1464.648484363745;1471.5070451398688;1472.4919902633574;1473.7789331600345;32911.177220569676;34796.82601586976;34846.53133839069;35325.470117947734;35447.468287975185;54970.450295496536;54999.17501237405;55354.44645553654;55449.44550554443;55453;464547;465264;466043;467336;469444;30619.54070688897;31679.683203167675;31882;31894.68105318917;32014;51866.22200666917;52049.479505204465;52368.47631523789;52609.210861836335;53055.734721326146;43404.78297608492;43693.56306436895;44211.33682994822;44504.55495445004;45015.774921126496;42830.14339713251;42885.57114428816;43862;43990;44173.77913110414;44981.55018449773;45548;45736.771316144535;45971;46033.30950035685;36555.26889462249;37820.24359512849;38260;38669.2266154681;38856.6114338853;29836.30656760273;30151.849240753654;30176.69823301739;30639.08082757521;30849.691503084683 13:26:47 INFO - PROCESS | 17023 | |2;jquery.html;421.27120082257693;426.42219792181595;429.195258889582;434.7174336681157;441.4239417560085;14458.710825783479;18149.546261343472;18778.342758003473;18783.154758035886;18884.244630214776;17992.820071799277;18234.361797337097;18476.353327633537;18805.435836924913;19044.238230470764;5563.221149039137;5594.076977298751;5799.623024503394;5819.883602327972;5823.039198532237;3708.4437334399786;5805.651660900359;5831.329397119322;5834.5624078194305;5841.7371218295275;5602.327720673525;5759.136129580555;5765.1928729977835;5782.074868021117;5789.363170051291;5777.220075289824;5790.7683692652245;5828.5337173026055;5829.504492118175;5836.095405212178;5048.6465947383695;5211.609129315317;5217.6608520446425;5217.817376391846;5229.581633469314;22615.434614134614;23154.7684523156;23209.535809283887;23472.413189670395;23518;2490.887910044052;2563;2591.243966466256;2613.59489279162;2675.933101672454;14973.625659358495;15030.398784048624;15041.323140458597;15170.089794612248;15192.164430956293;2032;2062.1339037604243;2169.197396963118;2172.2614311134134;2215.080741492279;57523;66956.3304366955;69952;82029.17970820275;82635.58682206551;10760.784784304271;10819.729506762395;10957.17821163416;11164.162687798447;11275.323480591027;15377.077375357514;15426.768598471032;15436.228188590525;15558.22208889551;15565.29956151976;8423.15768423165;8950.507722075348;8992.370534062553;9094.681686141086;9139.360244782934;8875.979262384908;8884.555772211364;9009.504477253682;9042.86435703465;9156.587953542106;4797.208460604031;4873.853784386474;4893.388326459192;4959.70241785494;4974.527419895104;2065.163608738463;2086.6869969504696;2107.294056491062;2124.224657999819;2152.1283880028614;489.6401145158306;496.12434053894907;949.7910459698855;1027.465717826726;1141.8866605060166;11674.824877626843;11693.473793679304;11712.70718232034;11842.171048026728;11937.761244775056;461.99538004619524;469.3991690635991;498.05866911537225;500.7045842952675;503.4135232454223;6416.582922110048;6485.805425837232;6594.736210551524;6627.569208001464;6683.097781799492;457160.71419643355;460067;462030;526734;543845;88260;89809.55095224612;91348;95225;96926.51536742412;1122.36586328724;1150.5340337163461;1180.2859270141612;1185.709501172201;1198.370855300974;16721.163941803105;16756.162191890602;16978.745318820474;17013.57466063358;17020.319187232868;39438.21123577455;39813.800930996316;40182.59817401788;40477.39283910685;40529.392059119724;58985.41014589971;59019;59741.701291493264;60711.39288607234;60866;8660.870086948828;9028.322875784212;9039.186473217442;9350.345475816628;9359.812803743751;13017.804732929204;13456.125351852099;13561.050726449053;13690.38393272325;13730.51943181984;6228;9625.796775403074;9773.657921972697;11688.649340519798;11965.641030769091;11612.071034317065;11752.177347585928;12116.697082573006;12117.15179937396;12203.69490762738;6597.175353080865;12057.457414416196;12286.341343918457;13017.609471715863;13102.148360356547;8560.186782255676;8795.428297160664;8880.422772519765;8976.685815996409;9118.589663465293;11086.445677716243;11488.942555287504;11570.88429115698;11732.296062236293;11864.288142711464 13:26:47 INFO - PROCESS | 17023 | |3;mootools.html;1565.2721484509705;1568.921553922304;1801.774778152731;1931.5074655962744;1943.8930858802769;7666.463347565673;8159.836803263931;8379.162083791625;8593.441426307294;8653.653853845846;8272;8369.372297077713;8438.620262088205;8443.240108390244;8448.91551084489;2315.8767997521145;2337.637666161748;2357.1867705641525;2357.681712968753;2358.740538540759;2300.539892021594;2339.6841426407386;2400.087966572709;2401.819863510235;2403.7956773674173;2357.422431504284;2414.7223069347074;2415.7946574541184;2419.5160967806423;2423.5516429460517;2227.587896239185;2247.685324054634;2277.3281881844896;2289.2445492987276;2295.380247333219;2360.3509035015336;2392.306231192952;2410.023940304162;2410.867402292873;2411.867347295898;8721.912780872173;8736.344774141964;8795.560221988875;8815.074417186168;8817.338699597556;5272.894542109175;5443.945560544384;5457.781688732446;5477.780888764445;5483.8080667176855;3299.2741596848655;3321.7674762766615;3334.3164651246434;3346.364190803764;3391.847366868497;993.3245393132667;1000.4947501511763;1012.0587853296431;1024.0987930621006;1027.2603725317758;12050.216735912138;12133.817992730115;12174.391280436032;12179.147459677826;12181.451834667461;4465.307877279027;4580.290055041474;4623.745693986863;4693.225617773098;4721.102990431876;9713.660021899199;9753.463559504153;9791.069848364394;9796.461194634363;9839.114479696862;5350.0904846176245;5380.381256155514;5395.757190926418;5396.622236443412;5396.703181324986;4456.309272062836;4892.217245240744;4911.238757992517;4962.950370496321;4996.100701873697;4066.1664358806374;4097.180563887235;4101.097758493127;4122.628963393309;4164.585539328322;1231.6797632615405;1242.9502819887284;1245.6200858738173;1247.8502579690496;1256.6544200344795;827.7765003449156;893.4148132972913;899.6851102114208;938.2869019545059;944.9669261575949;5920.585559010828;5937.52499800015;5949.553783466171;6000.519958403317;6025.440527537308;972.1153750087386;972.7616733900098;1030.6907927621683;1041.8489319048847;1059.2267644619471;4047.797610119482;4052.8986775330854;4117.155983023473;4127.690423218271;4130.091379896418;10434.947825260826;10886.510107045202;10898.07366373867;10926.890731092746;10940.945295273472;10475.47622618866;10627.628033018807;10744.623938162127;10745.785084298426;10750.193735469871;8500.74497765068;8510.31917446615;8564.443311184754;8590.1839325264;8597.269232115215;5512.751926163252;5718.142278658234;5821.825345239649;5876.794312199053;5879.911801322898;9039.90960090417;9211.76970575741;9373.390729602554;9479.810403792024;9505.19205867509;9228.769280768034;9459.337846350689;9545.427274363561;9556.76108097303;9808.950955245464;6854.2117656470145;7135.82160445993;7374.520656157332;7501.2123727007875;7553.093628764584;8100.432969692065;8131.390145738975;8148.674053037812;8150.959245203973;8189.754307370788;7001.8249543759775;7187.604681742554;7291.052163218747;7487.513311634726;7567.470277080552;7459.40324774006;7536.660850261642;7598.734044308423;7599.392048635986;7658.846823063619;6929.896051559332;6933.583984960918;6980.616066116209;7010.824729381806;7016.298370162943;4853.538913803183;4928.088303663833;4931.9753401232765;4942.3080768693135;5006.374203224597;4984.177610694195;5002.374703162105;5017.3226614406585;5073.264376665436;5101.183810590288 13:26:47 INFO - PROCESS | 17023 | |4;prototype.html;335.25573227435086;346.71569313163207;349.3432347187288;362.84397708985125;367.0145658905838;6660.234073081597;6668.866622667544;6762.594244345342;6789.796306110812;6801.557898736585;6589.505787065966;6625.17185351831;6647.202335719709;6654.833629159273;6660.46716262699;4682.695624784378;5002.699838009713;5011.548960593545;5017.397912250526;5021.924671129936;4853.635977301698;4929.088118698052;4940.382452193476;4953.058918805434;4954.479779623141;4871.780769865347;4899.975500122512;4918.286848406997;4922.089413458521;4928.088303663816;4883.804647814083;4887.511248875102;4903.583195428358;4920.188168952154;4936.111499930011;4376.824927002916;4397.076613911083;4398.252297109499;4401.911961760747;4402.075564131536;6440.162778838768;6454.483641308684;6472.093906853044;6486.51351148661;6489.4483968862705;5708.657480551139;5814;5837.708114594253;5847.619904706181;5867.383924687889;6958.304169583052;6984.720611175547;6989;7004.229534751174;7009.614471204081;4880.414350277953;4887.70475823907;4890.437599676012;4890.975545122287;4902.558769710708;7250.528715633467;7297.343239108506;7302.56184628924;7312.19565847751;7321.633918304064;4915.778789954461;4980.850574482772;5024.070546948826;5026.371703537058;5036.597072234213;5039.168537191395;5074.035933172685;5074.391073071181;5075.8984820303385;5076.771545280471;5750.741216645261;5767.8558036049435;5805.651660900359;5814.447627475383;5839.445252700986;7021.929780702229;7054.858902821915;7063.223045464994;7063.71745130189;7073.540219885691;1767.805541390446;1786.88385254958;1789.4810504953678;1791.9104044797707;1800.513861257453;1164.8078067119;1200.1898718365069;1204.644629834201;1204.9638510844688;1206.5053328135423;6821.079154314203;6827.931720682829;6834.521583489108;6835.521513494107;6838;7292.70829166838;7297.927020729725;7302.890456643155;7309.305615966475;7318;6625.668716564152;6752.020956961213;6826;6826.624535650488;6931.133608298963;3955.980220098881;3966.702497312713;3984.541777695602;3987.023179321085;3987.980060099739;7699.730509432143;7705.190954949761;7710.653020614086;7716.7684969451;7723;7499.700011999459;7508.1741008489025;7524.473286869867;7531.623418829036;7537.585432801248;7369.263073692695;7606.847863042597;7637.809054773675;7691.153973062958;7709.498882572615;7333.303336183054;7347.632618368953;7364.815879603053;7382.667779950022;7398.038255026812;7262.854742905218;7267.382272506896;7280.126384833854;7282.162551306667;7291.489595728461;7517.132678824746;7642.312191902755;7681.961590192013;7684.923150768421;7696.8460630788195;4844.103840789465;4918.43438004634;4924.532169443897;4928.088303663833;4931.556159945622;7285.453590980592;7297;7302.707891684273;7336.339729424164;7341.6696248670005;7102.609356485236;7109.253528379446;7141;7149.106361704787;7156.785296441115;6956.304369563003;7048.836941904528;7066.258042905421;7121.608311542915;7125.1093613298335;6948;7003.859922801414;7003.859922801617;7004.124484439445;7004.929950700428;7137.714491420285;7164.820879478055;7173.246809084971;7185.245549217257;7185.928140718735;6949.548279361826;6967.8606427870145;6985.5808651481075;6995.3004699531675;6996.6151861648095 13:26:47 INFO - PROCESS | 17023 | |5;yui.html;904.9457032578044;911.2391153386922;923.8383282925487;927.8608208768684;933.5052422216226;14500.347484363203;14558.563243102697;14877.702445951074;14960.850391496082;14992.325345359457;13425.194488330708;13438;13476.25880576568;13488.393022313994;13489.527866524673;911.3301723233418;911.5351170902854;926.393212445849;933.3186773655236;935.3312381647121;921.1893533690377;922.3313098003961;923.4320892651004;926.986095208569;929.8930622978377;948.7485816258697;957.2629075611775;958.104172598619;958.5925981457852;958.884933807944;958.5255298627189;960.2605993385055;961.3606951377326;961.7932144588912;964.161179773598;704.4188544450798;704.5103652961194;705.0411440440996;709.5848928376905;710.6127160697381;15304.923475382664;15464.845351546453;15475.922620386938;15482.845171548253;15498.845011549853;14146.080504767157;14323.069000515037;14332.355044023045;14435.639109022253;14469;11997.220180688315;12115.091368147336;12178.451969661386;12283.263004219685;12465.875341246563;3940.389239667856;3976.840926362942;3978.8607398741196;4048.9797551012352;4097.8770636880945;58020;58056.70971645157;58607.41392586062;58636.41363586352;58671.706641466946;11103.888961110448;11105.666829995112;11276.548938042386;11366.886331136748;11450.484728187252;20908.68636970447;21080.156793728387;21389.572208555743;21524.139034438445;21546.892265538885;7907.82171565092;8012.79968000793;8148.470349427387;8149.918500815034;8175.2642262195495;4749.786259618326;4846.127697014571;4937.530934561211;5008.524190201998;5051.747412629354;3728.993171843587;3770.6229377062073;3783.319002579507;3786.3373909565717;3787.981060094737;654.309703263062;674.4907594766019;677.8779819632514;682.5699809120322;684.4695361095191;567.4183961439475;625.7465726380823;684.7295318349323;708.3837061756202;727.436236916394;9087.182153606207;9103;9198.172164505228;9225.630974760934;9296.95351523238;646.4731244036095;685.3660364163129;711.2602892991231;712.9733184214714;713.6431784107946;4268.573142685706;4285.400043993844;4473.507914129443;4490.259107247333;4552.271636538138;61364.69317653383;61550.38449615536;62282.37717622856;69308.6534567324;69625;55009;55047.449525505035;55478;56590.71704641533;56846.7157664209;52512.212316815276;52799;53347;53381.733091334296;53450;9263.397879137834;9598.95200523993;9708.75728106803;9768.902310976799;9794.559244833858;36916.89249322525;37662.62337376591;38479.422808657335;38792;38823.805880971544;46526;46729;47989.28016079831;51814;51885.740571296905;11325.093992480417;11460.255083419552;11463.541458341573;11602.187846850977;11816.940915295369;13621.795673064713;13743.862561374259;13822.170669759444;13922.4431022762;14027.298635068002;12818.487260509848;12868.356582171042;13030.934845325713;13126.810675969162;13296.800547991594;13333.933330333286;13346.733065338445;13348.132371395828;13441.529546465827;13456.259905704888;12765.361731913554;13336.199828009961;13480.191188528328;13489.325533723078;13493.730125397633;10641.255112142386;11032.889671103187;11057.3861827444;11211.327320360804;11308.7738245233;10724;10957.83563246536;11087.889121109009;11342.94328528385;11357.54569817198 13:26:47 INFO - PROCESS | 17023 | __end_tp_report 13:26:47 INFO - PROCESS | 17023 | __start_cc_report 13:26:47 INFO - PROCESS | 17023 | _x_x_mozilla_cycle_collect,322 13:26:47 INFO - PROCESS | 17023 | __end_cc_report 13:26:47 INFO - PROCESS | 17023 | __startTimestamp1463171207444__endTimestamp 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | ------- Summary: start ------- 13:26:47 INFO - PROCESS | 17023 | Number of tests: 6 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | [#0] dojo.html Cycles:165 Average:5603.16 Median:5791.39 stddev:618.89 (10.7%) stddev-sans-first:593.66 13:26:47 INFO - PROCESS | 17023 | Values: 3293.1 3355.4 3396.5 3408.9 3427.9 5635.8 5637.3 5697.2 5705.2 5706.1 5660.0 5669.7 5682.6 5684.3 5692.9 5105.3 5144.7 5173.1 5212.9 5244.9 5047.3 5151.7 5289.9 5294.3 5301.2 5037.4 5190.4 5194.6 5267.3 5284.7 5143.7 5146.9 5162.3 5175.4 5194.0 4880.5 5013.3 5075.0 5126.0 5152.7 5456.0 5488.5 5506.3 5541.9 5566.9 5980.3 6011.9 6014.6 6020.3 6027.4 5890.4 5992.3 6068.4 6074.1 6079.1 5559.1 5603.1 5604.1 5637.1 5666.6 6138.2 6194.8 6205.5 6206.1 6207.5 5893.4 5927.6 5956.2 5956.8 5967.6 6006.0 6010.8 6039.1 6050.7 6085.4 5994.5 5999.7 6006.9 6007.7 6009.8 5828.8 5909.9 5931.6 6008.7 6011.9 4571.7 4577.7 4584.6 4592.6 4602.0 4094.8 4105.9 4115.3 4156.0 4163.1 5707.9 5720.6 5757.0 5797.3 5837.2 5951.7 5975.1 5999.3 5999.9 6018.3 5736.6 5752.9 5760.7 5761.8 5791.4 5092.9 5206.0 5242.7 5249.9 5259.3 6190.0 6196.4 6205.9 6213.8 6218.7 5933.6 5967.7 5984.2 5989.6 6000.0 6248.2 6266.4 6309.1 6309.9 6319.2 5936.7 6004.7 6020.4 6026.8 6060.8 5869.4 5982.0 6105.8 6114.2 6136.0 5998.8 5999.2 6000.8 6012.5 6037.0 5892.1 5933.5 5968.0 5969.3 5971.3 5650.4 5785.6 5795.0 5849.7 5859.7 5669.6 5751.3 5769.8 5811.9 5857.5 5594.2 5604.7 5640.3 5644.3 5656.9 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | [#1] ext.html Cycles:180 Average:64738.93 Median:44438.39 stddev:133160.68 (299.7%) stddev-sans-first:133447.19 13:26:47 INFO - PROCESS | 17023 | Values: 611.7 666.6 667.5 684.1 685.1 39235.0 40150.6 40335.6 40336.2 40372.0 43969.8 44402.8 44519.8 44647.6 44954.8 8892.3 9042.5 9138.5 9143.8 9153.3 8827.6 8936.2 8963.0 9167.4 9223.4 9157.0 9174.2 9193.0 9202.9 9217.4 9160.3 9179.3 9181.7 9194.2 9228.7 9108.4 9173.4 9246.9 9253.9 9263.7 43973.8 44178.0 44327.0 44474.0 44721.0 4017.9 4104.3 4201.9 4524.7 4565.2 34142.7 34186.7 34336.0 34412.5 35412.1 4613.8 4624.4 4632.0 4651.3 4653.3 312376.0 316245.0 316844.0 317968.0 318850.0 61023.7 61663.4 61968.0 61971.4 62107.4 70348.3 71576.3 71859.6 72399.0 72486.0 19601.5 19718.7 19838.1 19843.6 19921.3 15245.5 15280.2 15403.5 15417.2 15425.0 19949.2 20144.8 20358.1 20388.9 21146.6 7691.7 7853.4 7858.9 7900.9 8044.0 1116.9 1126.5 1164.3 1167.2 1167.4 32113.7 32157.7 33004.7 33212.3 33330.3 1133.5 1196.6 1230.3 1301.0 1326.9 17307.7 17751.6 17771.4 17940.5 18010.8 466284.0 628550.0 633529.0 652401.0 841764.0 56448.7 57582.4 57836.4 57842.8 57926.0 1413.4 1464.6 1471.5 1472.5 1473.8 32911.2 34796.8 34846.5 35325.5 35447.5 54970.5 54999.2 55354.4 55449.4 55453.0 464547.0 465264.0 466043.0 467336.0 469444.0 30619.5 31679.7 31882.0 31894.7 32014.0 51866.2 52049.5 52368.5 52609.2 53055.7 43404.8 43693.6 44211.3 44504.6 45015.8 42830.1 42885.6 43862.0 43990.0 44173.8 44981.6 45548.0 45736.8 45971.0 46033.3 36555.3 37820.2 38260.0 38669.2 38856.6 29836.3 30151.8 30176.7 30639.1 30849.7 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | [#2] jquery.html Cycles:180 Average:28527.16 Median:427.81 stddev:80954.08 (18923.0%) stddev-sans-first:81153.67 13:26:47 INFO - PROCESS | 17023 | Values: 421.3 426.4 429.2 434.7 441.4 14458.7 18149.5 18778.3 18783.2 18884.2 17992.8 18234.4 18476.4 18805.4 19044.2 5563.2 5594.1 5799.6 5819.9 5823.0 3708.4 5805.7 5831.3 5834.6 5841.7 5602.3 5759.1 5765.2 5782.1 5789.4 5777.2 5790.8 5828.5 5829.5 5836.1 5048.6 5211.6 5217.7 5217.8 5229.6 22615.4 23154.8 23209.5 23472.4 23518.0 2490.9 2563.0 2591.2 2613.6 2675.9 14973.6 15030.4 15041.3 15170.1 15192.2 2032.0 2062.1 2169.2 2172.3 2215.1 57523.0 66956.3 69952.0 82029.2 82635.6 10760.8 10819.7 10957.2 11164.2 11275.3 15377.1 15426.8 15436.2 15558.2 15565.3 8423.2 8950.5 8992.4 9094.7 9139.4 8876.0 8884.6 9009.5 9042.9 9156.6 4797.2 4873.9 4893.4 4959.7 4974.5 2065.2 2086.7 2107.3 2124.2 2152.1 489.6 496.1 949.8 1027.5 1141.9 11674.8 11693.5 11712.7 11842.2 11937.8 462.0 469.4 498.1 500.7 503.4 6416.6 6485.8 6594.7 6627.6 6683.1 457160.7 460067.0 462030.0 526734.0 543845.0 88260.0 89809.6 91348.0 95225.0 96926.5 1122.4 1150.5 1180.3 1185.7 1198.4 16721.2 16756.2 16978.7 17013.6 17020.3 39438.2 39813.8 40182.6 40477.4 40529.4 58985.4 59019.0 59741.7 60711.4 60866.0 8660.9 9028.3 9039.2 9350.3 9359.8 13017.8 13456.1 13561.1 13690.4 13730.5 6228.0 9625.8 9773.7 11688.6 11965.6 11612.1 11752.2 12116.7 12117.2 12203.7 6597.2 12057.5 12286.3 13017.6 13102.1 8560.2 8795.4 8880.4 8976.7 9118.6 11086.4 11488.9 11570.9 11732.3 11864.3 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | [#3] mootools.html Cycles:180 Average:5688.28 Median:5087.22 stddev:3158.12 (62.1%) stddev-sans-first:3151.78 13:26:47 INFO - PROCESS | 17023 | Values: 1565.3 1568.9 1801.8 1931.5 1943.9 7666.5 8159.8 8379.2 8593.4 8653.7 8272.0 8369.4 8438.6 8443.2 8448.9 2315.9 2337.6 2357.2 2357.7 2358.7 2300.5 2339.7 2400.1 2401.8 2403.8 2357.4 2414.7 2415.8 2419.5 2423.6 2227.6 2247.7 2277.3 2289.2 2295.4 2360.4 2392.3 2410.0 2410.9 2411.9 8721.9 8736.3 8795.6 8815.1 8817.3 5272.9 5443.9 5457.8 5477.8 5483.8 3299.3 3321.8 3334.3 3346.4 3391.8 993.3 1000.5 1012.1 1024.1 1027.3 12050.2 12133.8 12174.4 12179.1 12181.5 4465.3 4580.3 4623.7 4693.2 4721.1 9713.7 9753.5 9791.1 9796.5 9839.1 5350.1 5380.4 5395.8 5396.6 5396.7 4456.3 4892.2 4911.2 4963.0 4996.1 4066.2 4097.2 4101.1 4122.6 4164.6 1231.7 1243.0 1245.6 1247.9 1256.7 827.8 893.4 899.7 938.3 945.0 5920.6 5937.5 5949.6 6000.5 6025.4 972.1 972.8 1030.7 1041.8 1059.2 4047.8 4052.9 4117.2 4127.7 4130.1 10434.9 10886.5 10898.1 10926.9 10940.9 10475.5 10627.6 10744.6 10745.8 10750.2 8500.7 8510.3 8564.4 8590.2 8597.3 5512.8 5718.1 5821.8 5876.8 5879.9 9039.9 9211.8 9373.4 9479.8 9505.2 9228.8 9459.3 9545.4 9556.8 9809.0 6854.2 7135.8 7374.5 7501.2 7553.1 8100.4 8131.4 8148.7 8151.0 8189.8 7001.8 7187.6 7291.1 7487.5 7567.5 7459.4 7536.7 7598.7 7599.4 7658.8 6929.9 6933.6 6980.6 7010.8 7016.3 4853.5 4928.1 4932.0 4942.3 5006.4 4984.2 5002.4 5017.3 5073.3 5101.2 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | [#4] prototype.html Cycles:180 Average:5909.74 Median:6795.68 stddev:1812.46 (26.7%) stddev-sans-first:1768.59 13:26:47 INFO - PROCESS | 17023 | Values: 335.3 346.7 349.3 362.8 367.0 6660.2 6668.9 6762.6 6789.8 6801.6 6589.5 6625.2 6647.2 6654.8 6660.5 4682.7 5002.7 5011.5 5017.4 5021.9 4853.6 4929.1 4940.4 4953.1 4954.5 4871.8 4900.0 4918.3 4922.1 4928.1 4883.8 4887.5 4903.6 4920.2 4936.1 4376.8 4397.1 4398.3 4401.9 4402.1 6440.2 6454.5 6472.1 6486.5 6489.4 5708.7 5814.0 5837.7 5847.6 5867.4 6958.3 6984.7 6989.0 7004.2 7009.6 4880.4 4887.7 4890.4 4891.0 4902.6 7250.5 7297.3 7302.6 7312.2 7321.6 4915.8 4980.9 5024.1 5026.4 5036.6 5039.2 5074.0 5074.4 5075.9 5076.8 5750.7 5767.9 5805.7 5814.4 5839.4 7021.9 7054.9 7063.2 7063.7 7073.5 1767.8 1786.9 1789.5 1791.9 1800.5 1164.8 1200.2 1204.6 1205.0 1206.5 6821.1 6827.9 6834.5 6835.5 6838.0 7292.7 7297.9 7302.9 7309.3 7318.0 6625.7 6752.0 6826.0 6826.6 6931.1 3956.0 3966.7 3984.5 3987.0 3988.0 7699.7 7705.2 7710.7 7716.8 7723.0 7499.7 7508.2 7524.5 7531.6 7537.6 7369.3 7606.8 7637.8 7691.2 7709.5 7333.3 7347.6 7364.8 7382.7 7398.0 7262.9 7267.4 7280.1 7282.2 7291.5 7517.1 7642.3 7682.0 7684.9 7696.8 4844.1 4918.4 4924.5 4928.1 4931.6 7285.5 7297.0 7302.7 7336.3 7341.7 7102.6 7109.3 7141.0 7149.1 7156.8 6956.3 7048.8 7066.3 7121.6 7125.1 6948.0 7003.9 7003.9 7004.1 7004.9 7137.7 7164.8 7173.2 7185.2 7185.9 6949.5 6967.9 6985.6 6995.3 6996.6 13:26:47 INFO - PROCESS | 17023 | 13:26:47 INFO - PROCESS | 17023 | [#5] yui.html Cycles:180 Average:15574.58 Median:46627.50 stddev:18062.65 (38.7%) stddev-sans-first:18079.72 13:26:47 INFO - PROCESS | 17023 | Values: 904.9 911.2 923.8 927.9 933.5 14500.3 14558.6 14877.7 14960.9 14992.3 13425.2 13438.0 13476.3 13488.4 13489.5 911.3 911.5 926.4 933.3 935.3 921.2 922.3 923.4 927.0 929.9 948.7 957.3 958.1 958.6 958.9 958.5 960.3 961.4 961.8 964.2 704.4 704.5 705.0 709.6 710.6 15304.9 15464.8 15475.9 15482.8 15498.8 14146.1 14323.1 14332.4 14435.6 14469.0 11997.2 12115.1 12178.5 12283.3 12465.9 3940.4 3976.8 3978.9 4049.0 4097.9 58020.0 58056.7 58607.4 58636.4 58671.7 11103.9 11105.7 11276.5 11366.9 11450.5 20908.7 21080.2 21389.6 21524.1 21546.9 7907.8 8012.8 8148.5 8149.9 8175.3 4749.8 4846.1 4937.5 5008.5 5051.7 3729.0 3770.6 3783.3 3786.3 3788.0 654.3 674.5 677.9 682.6 684.5 567.4 625.7 684.7 708.4 727.4 9087.2 9103.0 9198.2 9225.6 9297.0 646.5 685.4 711.3 713.0 713.6 4268.6 4285.4 4473.5 4490.3 4552.3 61364.7 61550.4 62282.4 69308.7 69625.0 55009.0 55047.4 55478.0 56590.7 56846.7 52512.2 52799.0 53347.0 53381.7 53450.0 9263.4 9599.0 9708.8 9768.9 9794.6 36916.9 37662.6 38479.4 38792.0 38823.8 46526.0 46729.0 47989.3 51814.0 51885.7 11325.1 11460.3 11463.5 11602.2 11816.9 13621.8 13743.9 13822.2 13922.4 14027.3 12818.5 12868.4 13030.9 13126.8 13296.8 13333.9 13346.7 13348.1 13441.5 13456.3 12765.4 13336.2 13480.2 13489.3 13493.7 10641.3 11032.9 11057.4 11211.3 11308.8 10724.0 10957.8 11087.9 11342.9 11357.5 13:26:47 INFO - PROCESS | 17023 | -------- Summary: end -------- 13:26:47 INFO - PROCESS | 17023 | 13:26:48 INFO - TEST-INFO | 17023: exit 0 13:26:48 INFO - TEST-OK | dromaeo_css | took 1109919ms 13:26:48 INFO - TEST-START | kraken 13:26:48 INFO - operating with platform_type : linux_ 13:26:48 INFO - Initialising browser for kraken test... 13:26:48 INFO - TEST-INFO | started process 17273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsa9TtS/profile http://localhost:55188/getInfo.html) 13:26:51 INFO - PROCESS | 17273 | 13:26:51 INFO - PROCESS | 17273 | (process:17353): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:26:52 INFO - PROCESS | 17273 | __metrics Screen width/height:1600/1200 13:26:52 INFO - PROCESS | 17273 | colorDepth:24 13:26:52 INFO - PROCESS | 17273 | Browser inner width/height: 1024/697 13:26:52 INFO - PROCESS | 17273 | __metrics 13:26:53 ERROR - PROCESS | 17273 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 13:26:54 INFO - TEST-INFO | 17273: exit 0 13:26:54 INFO - Browser initialized. 13:26:54 INFO - Running cycle 1/1 for kraken test... 13:26:54 INFO - TEST-INFO | started process 17404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsa9TtS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:56 INFO - PROCESS | 17404 | 13:26:56 INFO - PROCESS | 17404 | (process:17473): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:27:06 INFO - PROCESS | 17404 | RSS: Main: 152461312 13:27:06 INFO - PROCESS | 17404 | 13:27:08 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55188/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:09 INFO - PROCESS | 17404 | RSS: Main: 157085696 13:27:09 INFO - PROCESS | 17404 | 13:27:12 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55188/tests/kraken/driver.html?testName=audio-dft) 13:27:12 INFO - PROCESS | 17404 | RSS: Main: 157081600 13:27:12 INFO - PROCESS | 17404 | 13:27:15 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55188/tests/kraken/driver.html?testName=audio-fft) 13:27:16 INFO - PROCESS | 17404 | RSS: Main: 157302784 13:27:16 INFO - PROCESS | 17404 | 13:27:18 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55188/tests/kraken/driver.html?testName=audio-oscillator) 13:27:19 INFO - PROCESS | 17404 | RSS: Main: 157425664 13:27:19 INFO - PROCESS | 17404 | 13:27:21 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:21 INFO - PROCESS | 17404 | RSS: Main: 157286400 13:27:21 INFO - PROCESS | 17404 | 13:27:24 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55188/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:25 INFO - PROCESS | 17404 | RSS: Main: 156807168 13:27:25 INFO - PROCESS | 17404 | 13:27:28 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55188/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:29 INFO - PROCESS | 17404 | RSS: Main: 157573120 13:27:29 INFO - PROCESS | 17404 | 13:27:32 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55188/tests/kraken/driver.html?testName=json-parse-financial) 13:27:32 INFO - PROCESS | 17404 | RSS: Main: 156831744 13:27:32 INFO - PROCESS | 17404 | 13:27:34 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:35 INFO - PROCESS | 17404 | RSS: Main: 157102080 13:27:35 INFO - PROCESS | 17404 | 13:27:36 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:37 INFO - PROCESS | 17404 | RSS: Main: 157237248 13:27:37 INFO - PROCESS | 17404 | 13:27:39 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:40 INFO - PROCESS | 17404 | RSS: Main: 157265920 13:27:40 INFO - PROCESS | 17404 | 13:27:42 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:43 INFO - PROCESS | 17404 | RSS: Main: 157790208 13:27:43 INFO - PROCESS | 17404 | 13:27:45 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:27:46 INFO - PROCESS | 17404 | RSS: Main: 157650944 13:27:46 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | Cycle 1(1): loaded http://localhost:55188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55188/tests/kraken/driver.html?testName=ai-astar) 13:27:48 INFO - PROCESS | 17404 | RSS: Main: 158793728 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | __start_tp_report 13:27:48 INFO - PROCESS | 17404 | _x_x_mozilla_page_load 13:27:48 INFO - PROCESS | 17404 | _x_x_mozilla_page_load_details 13:27:48 INFO - PROCESS | 17404 | |i|pagename|runs| 13:27:48 INFO - PROCESS | 17404 | |0;ai-astar;108;111;104;110;114;111;101;112;112;111 13:27:48 INFO - PROCESS | 17404 | |1;audio-beat-detection;158;129;159;178;129;159;160;128;190;128 13:27:48 INFO - PROCESS | 17404 | |2;audio-dft;166;163;164;162;164;163;163;161;164;162 13:27:48 INFO - PROCESS | 17404 | |3;audio-fft;77;76;77;173;75;75;75;77;164;74 13:27:48 INFO - PROCESS | 17404 | |4;audio-oscillator;93;93;150;92;93;94;155;92;93;144 13:27:48 INFO - PROCESS | 17404 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;122;118;118 13:27:48 INFO - PROCESS | 17404 | |6;imaging-darkroom;147;147;147;146;147;148;147;147;146;146 13:27:48 INFO - PROCESS | 17404 | |7;imaging-desaturate;95;95;96;97;96;96;95;95;96;95 13:27:48 INFO - PROCESS | 17404 | |8;json-parse-financial;54;56;58;55;55;56;58;74;57;54 13:27:48 INFO - PROCESS | 17404 | |9;json-stringify-tinderbox;58;59;58;63;59;57;58;60;58;59 13:27:48 INFO - PROCESS | 17404 | |10;stanford-crypto-aes;74;74;75;75;75;75;75;76;75;75 13:27:48 INFO - PROCESS | 17404 | |11;stanford-crypto-ccm;114;119;113;117;116;114;115;114;131;126 13:27:48 INFO - PROCESS | 17404 | |12;stanford-crypto-pbkdf2;161;161;162;158;170;163;169;169;157;163 13:27:48 INFO - PROCESS | 17404 | |13;stanford-crypto-sha256-iterative;67;68;67;69;73;70;68;65;65;65 13:27:48 INFO - PROCESS | 17404 | __end_tp_report 13:27:48 INFO - PROCESS | 17404 | __start_cc_report 13:27:48 INFO - PROCESS | 17404 | _x_x_mozilla_cycle_collect,827 13:27:48 INFO - PROCESS | 17404 | __end_cc_report 13:27:48 INFO - PROCESS | 17404 | __startTimestamp1463171268454__endTimestamp 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | ------- Summary: start ------- 13:27:48 INFO - PROCESS | 17404 | Number of tests: 14 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:4.01 (3.6%) stddev-sans-first:4.22 13:27:48 INFO - PROCESS | 17404 | Values: 108.0 111.0 104.0 110.0 114.0 111.0 101.0 112.0 112.0 111.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:159.00 stddev:22.43 (14.1%) stddev-sans-first:23.68 13:27:48 INFO - PROCESS | 17404 | Values: 158.0 129.0 159.0 178.0 129.0 159.0 160.0 128.0 190.0 128.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.40 (0.9%) stddev-sans-first:1.05 13:27:48 INFO - PROCESS | 17404 | Values: 166.0 163.0 164.0 162.0 164.0 163.0 163.0 161.0 164.0 162.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:39.18 (51.9%) stddev-sans-first:41.05 13:27:48 INFO - PROCESS | 17404 | Values: 77.0 76.0 77.0 173.0 75.0 75.0 75.0 77.0 164.0 74.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.57 (29.6%) stddev-sans-first:28.56 13:27:48 INFO - PROCESS | 17404 | Values: 93.0 93.0 150.0 92.0 93.0 94.0 155.0 92.0 93.0 144.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 13:27:48 INFO - PROCESS | 17404 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 122.0 118.0 118.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:27:48 INFO - PROCESS | 17404 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 146.0 146.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 13:27:48 INFO - PROCESS | 17404 | Values: 95.0 95.0 96.0 97.0 96.0 96.0 95.0 95.0 96.0 95.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.50 stddev:5.91 (10.5%) stddev-sans-first:6.11 13:27:48 INFO - PROCESS | 17404 | Values: 54.0 56.0 58.0 55.0 55.0 56.0 58.0 74.0 57.0 54.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:1.66 (2.8%) stddev-sans-first:1.73 13:27:48 INFO - PROCESS | 17404 | Values: 58.0 59.0 58.0 63.0 59.0 57.0 58.0 60.0 58.0 59.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 13:27:48 INFO - PROCESS | 17404 | Values: 74.0 74.0 75.0 75.0 75.0 75.0 75.0 76.0 75.0 75.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:116.50 stddev:5.97 (5.1%) stddev-sans-first:6.16 13:27:48 INFO - PROCESS | 17404 | Values: 114.0 119.0 113.0 117.0 116.0 114.0 115.0 114.0 131.0 126.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:163.00 stddev:4.60 (2.8%) stddev-sans-first:4.80 13:27:48 INFO - PROCESS | 17404 | Values: 161.0 161.0 162.0 158.0 170.0 163.0 169.0 169.0 157.0 163.0 13:27:48 INFO - PROCESS | 17404 | 13:27:48 INFO - PROCESS | 17404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:2.54 (3.7%) stddev-sans-first:2.68 13:27:48 INFO - PROCESS | 17404 | Values: 67.0 68.0 67.0 69.0 73.0 70.0 68.0 65.0 65.0 65.0 13:27:48 INFO - PROCESS | 17404 | -------- Summary: end -------- 13:27:48 INFO - PROCESS | 17404 | 13:27:49 INFO - TEST-INFO | 17404: exit 0 13:27:49 INFO - TEST-OK | kraken | took 61306ms 13:27:49 INFO - SUITE-END | took 1171s 13:27:49 INFO - Completed test suite (00:19:31) 13:27:49 INFO - javascript benchmark 13:27:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.1108600677812, 3355.379254837855, 3396.5414669019674, 3408.863645454182, 3427.8800241991535, 5635.83092507225, 5637.3235211774645, 5697.202391665171, 5705.172749951254, 5706.087026075828, 5660.0, 5669.688167150805, 5682.6306290091115, 5684.261046064006, 5692.9146062809095, 5105.336306280178, 5144.691318520882, 5173.094708426029, 5212.921806172911, 5244.8688782780355, 5047.318611987372, 5151.74241287936, 5289.947100529003, 5294.258803767457, 5301.204819277101, 5037.395512538501, 5190.4290528042075, 5194.584433245332, 5267.315249017623, 5284.735763211843, 5143.742812859361, 5146.897062058775, 5162.303089082982, 5175.404828444702, 5194.039102766001, 4880.536349046871, 5013.273075404082, 5074.985002999378, 5125.974370128126, 5152.690838549699, 5455.972720136414, 5488.506034456878, 5506.256655351516, 5541.944580554183, 5566.86082847928, 5980.34216236218, 6011.879762404771, 6014.609050411753, 6020.337762846083, 6027.367126451703, 5890.381509941437, 5992.310884248323, 6068.393160683941, 6074.088886666991, 6079.118527813486, 5559.11054231321, 5603.10350343943, 5604.103343465026, 5637.069883469223, 5666.575006874501, 6138.1713468681155, 6194.752209911553, 6205.503559715212, 6206.100115483229, 6207.534434917399, 5893.410658934158, 5927.614705044159, 5956.225690660186, 5956.821295361146, 5967.5524335675, 6006.009008513546, 6010.759569617167, 6039.063945088518, 6050.667213303311, 6085.361037091042, 5994.490468310155, 5999.670018149044, 6006.939930600638, 6007.699615019232, 6009.789657361971, 5828.825135245865, 5909.936211481974, 5931.6441013539325, 6008.699565021819, 6011.939880601138, 4571.657125715585, 4577.748223847654, 4584.61030812378, 4592.609628181642, 4602.0, 4094.815733292009, 4105.938410923838, 4115.259253334429, 4156.044109854751, 4163.12574359388, 5707.885842283131, 5720.628159169641, 5757.021306377926, 5797.304323481209, 5837.211976383134, 5951.702414879239, 5975.07386355107, 5999.310079340845, 5999.850003749942, 6018.277806663228, 5736.598438109292, 5752.913706294409, 5760.74076666551, 5761.827145185567, 5791.391903850119, 5092.949070509321, 5206.036883176549, 5242.711650859239, 5249.868753281198, 5259.263703081571, 6189.96905015472, 6196.442320191204, 6205.937940620626, 6213.813585592439, 6218.657973811393, 5933.584649074696, 5967.731452084753, 5984.162217289496, 5989.550783691154, 5999.970000149971, 6248.187735594343, 6266.404691554295, 6309.085182648582, 6309.936900630935, 6319.210098737658, 5936.673482958478, 6004.699765011819, 6020.39796020412, 6026.849328766816, 6060.757569697339, 5869.383714709894, 5981.970090149522, 6105.786297479567, 6114.2357205349335, 6136.0, 5998.820035398945, 5999.1601175836295, 6000.759969601167, 6012.549058820518, 6037.034074548052, 5892.145638882424, 5933.465988061095, 5968.045112781934, 5969.253843269591, 5971.343152253336, 5650.434956504481, 5785.56608254391, 5794.971025144847, 5849.707514624337, 5859.677717725566, 5669.574781891292, 5751.252337196138, 5769.826905192851, 5811.912821307599, 5857.5313974881055, 5594.188842617717, 5604.663720176803, 5640.294963129609, 5644.294463192101, 5656.915146272891], "value": 5563.027411051338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.6819253987926, 666.6033709942584, 667.4993754683987, 684.0867441964976, 685.0990946904823, 39235.0, 40150.59849401505, 40335.596644033554, 40336.193276134494, 40372.0, 43969.78015109928, 44402.77798611011, 44519.77740111303, 44647.55352446475, 44954.77522612391, 8892.333075019367, 9042.502662353569, 9138.497382643953, 9143.817123657524, 9153.313501487382, 8827.558622068904, 8936.240419564312, 8963.0, 9167.44995300284, 9223.446593204395, 9157.0, 9174.220191283748, 9192.954035229814, 9202.907970920272, 9217.446953182796, 9160.267178625727, 9179.265658747318, 9181.67864124759, 9194.172524472797, 9228.723138305795, 9108.407953483002, 9173.403728757676, 9246.907530924673, 9253.907460925371, 9263.675771348038, 43973.78013109946, 44178.0, 44327.0, 44474.0, 44721.0, 4017.9196416071513, 4104.343305071175, 4201.936970945439, 4524.660650451229, 4565.178267911774, 34142.6585734142, 34186.658133418845, 34336.0, 34412.483812742576, 35412.11469713252, 4613.8154473821005, 4624.35259063728, 4631.976840115778, 4651.301440303685, 4653.255479123324, 312375.99999999773, 316245.0, 316844.0, 317968.0, 318850.0, 61023.694881525305, 61663.38336616576, 61968.0, 61971.38028619656, 62107.378926210156, 70348.29651703418, 71576.284237158, 71859.64070179616, 72399.0, 72486.0, 19601.509962251057, 19718.70421943672, 19838.107285172202, 19843.60312793736, 19921.302754403816, 15245.466408675644, 15280.159591222367, 15403.537893863202, 15417.152056636993, 15425.0, 19949.202031918852, 20144.798552014585, 20358.083886225155, 20388.898055509922, 21146.577068458544, 7691.692891752858, 7853.41099417546, 7858.882116768253, 7900.920990790133, 8044.0, 1116.9273997190157, 1126.4818183635455, 1164.2897832322276, 1167.235460773195, 1167.416291854073, 32113.67886321107, 32157.678423215937, 33004.66995330016, 33212.3357532848, 33330.33339333248, 1133.54091592905, 1196.5512932650256, 1230.3479156047308, 1300.9869901301056, 1326.9336533173496, 17307.740383894252, 17751.55621109457, 17771.378001769877, 17940.461786146436, 18010.819891801177, 466284.0, 628550.0, 633529.0, 652401.0, 841764.0, 56448.71775641095, 57582.424175757704, 57836.42163578395, 57842.8431431369, 57926.0, 1413.4134334251376, 1464.648484363745, 1471.5070451398688, 1472.4919902633574, 1473.7789331600345, 32911.177220569676, 34796.82601586976, 34846.53133839069, 35325.470117947734, 35447.468287975185, 54970.450295496536, 54999.17501237405, 55354.44645553654, 55449.44550554443, 55453.0, 464547.0, 465264.0, 466043.0, 467336.0, 469444.0, 30619.54070688897, 31679.683203167675, 31882.0, 31894.68105318917, 32014.0, 51866.22200666917, 52049.479505204465, 52368.47631523789, 52609.210861836335, 53055.734721326146, 43404.78297608492, 43693.56306436895, 44211.33682994822, 44504.55495445004, 45015.774921126496, 42830.14339713251, 42885.57114428816, 43862.0, 43990.0, 44173.77913110414, 44981.55018449773, 45548.0, 45736.771316144535, 45971.0, 46033.30950035685, 36555.26889462249, 37820.24359512849, 38260.0, 38669.2266154681, 38856.6114338853, 29836.30656760273, 30151.849240753654, 30176.69823301739, 30639.08082757521, 30849.691503084683], "value": 21574.76830305771, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.27120082257693, 426.42219792181595, 429.195258889582, 434.7174336681157, 441.4239417560085, 14458.710825783479, 18149.546261343472, 18778.342758003473, 18783.154758035886, 18884.244630214776, 17992.820071799277, 18234.361797337097, 18476.353327633537, 18805.435836924913, 19044.238230470764, 5563.221149039137, 5594.076977298751, 5799.623024503394, 5819.883602327972, 5823.039198532237, 3708.4437334399786, 5805.651660900359, 5831.329397119322, 5834.5624078194305, 5841.7371218295275, 5602.327720673525, 5759.136129580555, 5765.1928729977835, 5782.074868021117, 5789.363170051291, 5777.220075289824, 5790.7683692652245, 5828.5337173026055, 5829.504492118175, 5836.095405212178, 5048.6465947383695, 5211.609129315317, 5217.6608520446425, 5217.817376391846, 5229.581633469314, 22615.434614134614, 23154.7684523156, 23209.535809283887, 23472.413189670395, 23518.0, 2490.887910044052, 2563.0, 2591.243966466256, 2613.59489279162, 2675.933101672454, 14973.625659358495, 15030.398784048624, 15041.323140458597, 15170.089794612248, 15192.164430956293, 2032.0, 2062.1339037604243, 2169.197396963118, 2172.2614311134134, 2215.080741492279, 57523.0, 66956.3304366955, 69952.0, 82029.17970820275, 82635.58682206551, 10760.784784304271, 10819.729506762395, 10957.17821163416, 11164.162687798447, 11275.323480591027, 15377.077375357514, 15426.768598471032, 15436.228188590525, 15558.22208889551, 15565.29956151976, 8423.15768423165, 8950.507722075348, 8992.370534062553, 9094.681686141086, 9139.360244782934, 8875.979262384908, 8884.555772211364, 9009.504477253682, 9042.86435703465, 9156.587953542106, 4797.208460604031, 4873.853784386474, 4893.388326459192, 4959.70241785494, 4974.527419895104, 2065.163608738463, 2086.6869969504696, 2107.294056491062, 2124.224657999819, 2152.1283880028614, 489.6401145158306, 496.12434053894907, 949.7910459698855, 1027.465717826726, 1141.8866605060166, 11674.824877626843, 11693.473793679304, 11712.70718232034, 11842.171048026728, 11937.761244775056, 461.99538004619524, 469.3991690635991, 498.05866911537225, 500.7045842952675, 503.4135232454223, 6416.582922110048, 6485.805425837232, 6594.736210551524, 6627.569208001464, 6683.097781799492, 457160.71419643355, 460067.0, 462030.0, 526734.0, 543845.0, 88260.0, 89809.55095224612, 91348.0, 95225.0, 96926.51536742412, 1122.36586328724, 1150.5340337163461, 1180.2859270141612, 1185.709501172201, 1198.370855300974, 16721.163941803105, 16756.162191890602, 16978.745318820474, 17013.57466063358, 17020.319187232868, 39438.21123577455, 39813.800930996316, 40182.59817401788, 40477.39283910685, 40529.392059119724, 58985.41014589971, 59019.0, 59741.701291493264, 60711.39288607234, 60866.0, 8660.870086948828, 9028.322875784212, 9039.186473217442, 9350.345475816628, 9359.812803743751, 13017.804732929204, 13456.125351852099, 13561.050726449053, 13690.38393272325, 13730.51943181984, 6228.0, 9625.796775403074, 9773.657921972697, 11688.649340519798, 11965.641030769091, 11612.071034317065, 11752.177347585928, 12116.697082573006, 12117.15179937396, 12203.69490762738, 6597.175353080865, 12057.457414416196, 12286.341343918457, 13017.609471715863, 13102.148360356547, 8560.186782255676, 8795.428297160664, 8880.422772519765, 8976.685815996409, 9118.589663465293, 11086.445677716243, 11488.942555287504, 11570.88429115698, 11732.296062236293, 11864.288142711464], "value": 8924.54400970275, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1565.2721484509705, 1568.921553922304, 1801.774778152731, 1931.5074655962744, 1943.8930858802769, 7666.463347565673, 8159.836803263931, 8379.162083791625, 8593.441426307294, 8653.653853845846, 8272.0, 8369.372297077713, 8438.620262088205, 8443.240108390244, 8448.91551084489, 2315.8767997521145, 2337.637666161748, 2357.1867705641525, 2357.681712968753, 2358.740538540759, 2300.539892021594, 2339.6841426407386, 2400.087966572709, 2401.819863510235, 2403.7956773674173, 2357.422431504284, 2414.7223069347074, 2415.7946574541184, 2419.5160967806423, 2423.5516429460517, 2227.587896239185, 2247.685324054634, 2277.3281881844896, 2289.2445492987276, 2295.380247333219, 2360.3509035015336, 2392.306231192952, 2410.023940304162, 2410.867402292873, 2411.867347295898, 8721.912780872173, 8736.344774141964, 8795.560221988875, 8815.074417186168, 8817.338699597556, 5272.894542109175, 5443.945560544384, 5457.781688732446, 5477.780888764445, 5483.8080667176855, 3299.2741596848655, 3321.7674762766615, 3334.3164651246434, 3346.364190803764, 3391.847366868497, 993.3245393132667, 1000.4947501511763, 1012.0587853296431, 1024.0987930621006, 1027.2603725317758, 12050.216735912138, 12133.817992730115, 12174.391280436032, 12179.147459677826, 12181.451834667461, 4465.307877279027, 4580.290055041474, 4623.745693986863, 4693.225617773098, 4721.102990431876, 9713.660021899199, 9753.463559504153, 9791.069848364394, 9796.461194634363, 9839.114479696862, 5350.0904846176245, 5380.381256155514, 5395.757190926418, 5396.622236443412, 5396.703181324986, 4456.309272062836, 4892.217245240744, 4911.238757992517, 4962.950370496321, 4996.100701873697, 4066.1664358806374, 4097.180563887235, 4101.097758493127, 4122.628963393309, 4164.585539328322, 1231.6797632615405, 1242.9502819887284, 1245.6200858738173, 1247.8502579690496, 1256.6544200344795, 827.7765003449156, 893.4148132972913, 899.6851102114208, 938.2869019545059, 944.9669261575949, 5920.585559010828, 5937.52499800015, 5949.553783466171, 6000.519958403317, 6025.440527537308, 972.1153750087386, 972.7616733900098, 1030.6907927621683, 1041.8489319048847, 1059.2267644619471, 4047.797610119482, 4052.8986775330854, 4117.155983023473, 4127.690423218271, 4130.091379896418, 10434.947825260826, 10886.510107045202, 10898.07366373867, 10926.890731092746, 10940.945295273472, 10475.47622618866, 10627.628033018807, 10744.623938162127, 10745.785084298426, 10750.193735469871, 8500.74497765068, 8510.31917446615, 8564.443311184754, 8590.1839325264, 8597.269232115215, 5512.751926163252, 5718.142278658234, 5821.825345239649, 5876.794312199053, 5879.911801322898, 9039.90960090417, 9211.76970575741, 9373.390729602554, 9479.810403792024, 9505.19205867509, 9228.769280768034, 9459.337846350689, 9545.427274363561, 9556.76108097303, 9808.950955245464, 6854.2117656470145, 7135.82160445993, 7374.520656157332, 7501.2123727007875, 7553.093628764584, 8100.432969692065, 8131.390145738975, 8148.674053037812, 8150.959245203973, 8189.754307370788, 7001.8249543759775, 7187.604681742554, 7291.052163218747, 7487.513311634726, 7567.470277080552, 7459.40324774006, 7536.660850261642, 7598.734044308423, 7599.392048635986, 7658.846823063619, 6929.896051559332, 6933.583984960918, 6980.616066116209, 7010.824729381806, 7016.298370162943, 4853.538913803183, 4928.088303663833, 4931.9753401232765, 4942.3080768693135, 5006.374203224597, 4984.177610694195, 5002.374703162105, 5017.3226614406585, 5073.264376665436, 5101.183810590288], "value": 4591.0877802101395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.25573227435086, 346.71569313163207, 349.3432347187288, 362.84397708985125, 367.0145658905838, 6660.234073081597, 6668.866622667544, 6762.594244345342, 6789.796306110812, 6801.557898736585, 6589.505787065966, 6625.17185351831, 6647.202335719709, 6654.833629159273, 6660.46716262699, 4682.695624784378, 5002.699838009713, 5011.548960593545, 5017.397912250526, 5021.924671129936, 4853.635977301698, 4929.088118698052, 4940.382452193476, 4953.058918805434, 4954.479779623141, 4871.780769865347, 4899.975500122512, 4918.286848406997, 4922.089413458521, 4928.088303663816, 4883.804647814083, 4887.511248875102, 4903.583195428358, 4920.188168952154, 4936.111499930011, 4376.824927002916, 4397.076613911083, 4398.252297109499, 4401.911961760747, 4402.075564131536, 6440.162778838768, 6454.483641308684, 6472.093906853044, 6486.51351148661, 6489.4483968862705, 5708.657480551139, 5814.0, 5837.708114594253, 5847.619904706181, 5867.383924687889, 6958.304169583052, 6984.720611175547, 6989.0, 7004.229534751174, 7009.614471204081, 4880.414350277953, 4887.70475823907, 4890.437599676012, 4890.975545122287, 4902.558769710708, 7250.528715633467, 7297.343239108506, 7302.56184628924, 7312.19565847751, 7321.633918304064, 4915.778789954461, 4980.850574482772, 5024.070546948826, 5026.371703537058, 5036.597072234213, 5039.168537191395, 5074.035933172685, 5074.391073071181, 5075.8984820303385, 5076.771545280471, 5750.741216645261, 5767.8558036049435, 5805.651660900359, 5814.447627475383, 5839.445252700986, 7021.929780702229, 7054.858902821915, 7063.223045464994, 7063.71745130189, 7073.540219885691, 1767.805541390446, 1786.88385254958, 1789.4810504953678, 1791.9104044797707, 1800.513861257453, 1164.8078067119, 1200.1898718365069, 1204.644629834201, 1204.9638510844688, 1206.5053328135423, 6821.079154314203, 6827.931720682829, 6834.521583489108, 6835.521513494107, 6838.0, 7292.70829166838, 7297.927020729725, 7302.890456643155, 7309.305615966475, 7318.0, 6625.668716564152, 6752.020956961213, 6826.0, 6826.624535650488, 6931.133608298963, 3955.980220098881, 3966.702497312713, 3984.541777695602, 3987.023179321085, 3987.980060099739, 7699.730509432143, 7705.190954949761, 7710.653020614086, 7716.7684969451, 7723.0, 7499.700011999459, 7508.1741008489025, 7524.473286869867, 7531.623418829036, 7537.585432801248, 7369.263073692695, 7606.847863042597, 7637.809054773675, 7691.153973062958, 7709.498882572615, 7333.303336183054, 7347.632618368953, 7364.815879603053, 7382.667779950022, 7398.038255026812, 7262.854742905218, 7267.382272506896, 7280.126384833854, 7282.162551306667, 7291.489595728461, 7517.132678824746, 7642.312191902755, 7681.961590192013, 7684.923150768421, 7696.8460630788195, 4844.103840789465, 4918.43438004634, 4924.532169443897, 4928.088303663833, 4931.556159945622, 7285.453590980592, 7297.0, 7302.707891684273, 7336.339729424164, 7341.6696248670005, 7102.609356485236, 7109.253528379446, 7141.0, 7149.106361704787, 7156.785296441115, 6956.304369563003, 7048.836941904528, 7066.258042905421, 7121.608311542915, 7125.1093613298335, 6948.0, 7003.859922801414, 7003.859922801617, 7004.124484439445, 7004.929950700428, 7137.714491420285, 7164.820879478055, 7173.246809084971, 7185.245549217257, 7185.928140718735, 6949.548279361826, 6967.8606427870145, 6985.5808651481075, 6995.3004699531675, 6996.6151861648095], "value": 5313.936617281171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.9457032578044, 911.2391153386922, 923.8383282925487, 927.8608208768684, 933.5052422216226, 14500.347484363203, 14558.563243102697, 14877.702445951074, 14960.850391496082, 14992.325345359457, 13425.194488330708, 13438.0, 13476.25880576568, 13488.393022313994, 13489.527866524673, 911.3301723233418, 911.5351170902854, 926.393212445849, 933.3186773655236, 935.3312381647121, 921.1893533690377, 922.3313098003961, 923.4320892651004, 926.986095208569, 929.8930622978377, 948.7485816258697, 957.2629075611775, 958.104172598619, 958.5925981457852, 958.884933807944, 958.5255298627189, 960.2605993385055, 961.3606951377326, 961.7932144588912, 964.161179773598, 704.4188544450798, 704.5103652961194, 705.0411440440996, 709.5848928376905, 710.6127160697381, 15304.923475382664, 15464.845351546453, 15475.922620386938, 15482.845171548253, 15498.845011549853, 14146.080504767157, 14323.069000515037, 14332.355044023045, 14435.639109022253, 14469.0, 11997.220180688315, 12115.091368147336, 12178.451969661386, 12283.263004219685, 12465.875341246563, 3940.389239667856, 3976.840926362942, 3978.8607398741196, 4048.9797551012352, 4097.8770636880945, 58020.0, 58056.70971645157, 58607.41392586062, 58636.41363586352, 58671.706641466946, 11103.888961110448, 11105.666829995112, 11276.548938042386, 11366.886331136748, 11450.484728187252, 20908.68636970447, 21080.156793728387, 21389.572208555743, 21524.139034438445, 21546.892265538885, 7907.82171565092, 8012.79968000793, 8148.470349427387, 8149.918500815034, 8175.2642262195495, 4749.786259618326, 4846.127697014571, 4937.530934561211, 5008.524190201998, 5051.747412629354, 3728.993171843587, 3770.6229377062073, 3783.319002579507, 3786.3373909565717, 3787.981060094737, 654.309703263062, 674.4907594766019, 677.8779819632514, 682.5699809120322, 684.4695361095191, 567.4183961439475, 625.7465726380823, 684.7295318349323, 708.3837061756202, 727.436236916394, 9087.182153606207, 9103.0, 9198.172164505228, 9225.630974760934, 9296.95351523238, 646.4731244036095, 685.3660364163129, 711.2602892991231, 712.9733184214714, 713.6431784107946, 4268.573142685706, 4285.400043993844, 4473.507914129443, 4490.259107247333, 4552.271636538138, 61364.69317653383, 61550.38449615536, 62282.37717622856, 69308.6534567324, 69625.0, 55009.0, 55047.449525505035, 55478.0, 56590.71704641533, 56846.7157664209, 52512.212316815276, 52799.0, 53347.0, 53381.733091334296, 53450.0, 9263.397879137834, 9598.95200523993, 9708.75728106803, 9768.902310976799, 9794.559244833858, 36916.89249322525, 37662.62337376591, 38479.422808657335, 38792.0, 38823.805880971544, 46526.0, 46729.0, 47989.28016079831, 51814.0, 51885.740571296905, 11325.093992480417, 11460.255083419552, 11463.541458341573, 11602.187846850977, 11816.940915295369, 13621.795673064713, 13743.862561374259, 13822.170669759444, 13922.4431022762, 14027.298635068002, 12818.487260509848, 12868.356582171042, 13030.934845325713, 13126.810675969162, 13296.800547991594, 13333.933330333286, 13346.733065338445, 13348.132371395828, 13441.529546465827, 13456.259905704888, 12765.361731913554, 13336.199828009961, 13480.191188528328, 13489.325533723078, 13493.730125397633, 10641.255112142386, 11032.889671103187, 11057.3861827444, 11211.327320360804, 11308.7738245233, 10724.0, 10957.83563246536, 11087.889121109009, 11342.94328528385, 11357.54569817198], "value": 7107.776157363161, "unit": "score"}], "name": "dromaeo_css", "value": 7553.671003349057, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 110.0, 114.0, 111.0, 101.0, 112.0, 112.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 159.0, 178.0, 129.0, 159.0, 160.0, 128.0, 190.0, 128.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 162.0, 164.0, 163.0, 163.0, 161.0, 164.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 173.0, 75.0, 75.0, 75.0, 77.0, 164.0, 74.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 92.0, 93.0, 94.0, 155.0, 92.0, 93.0, 144.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 122.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 58.0, 55.0, 55.0, 56.0, 58.0, 74.0, 57.0, 54.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 63.0, 59.0, 57.0, 58.0, 60.0, 58.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 75.0, 75.0, 75.0, 76.0, 75.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 113.0, 117.0, 116.0, 114.0, 115.0, 114.0, 131.0, 126.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 158.0, 170.0, 163.0, 169.0, 169.0, 157.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 69.0, 73.0, 70.0, 68.0, 65.0, 65.0, 65.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1529.3000000000002, "alertThreshold": 2.0}]} 13:27:49 INFO - Return code: 0 13:27:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:27:49 ERROR - # TBPL SUCCESS # 13:27:49 INFO - Running post-action listener: _resource_record_post_action 13:27:49 INFO - Running post-run listener: _resource_record_post_run 13:27:50 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365645824; Read time: 8; Write time: 705976 13:27:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119562240; Read time: 0; Write time: 224908 13:27:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 242479104; Read time: 8; Write time: 480864 13:27:50 INFO - Running post-run listener: _upload_blobber_files 13:27:50 INFO - Blob upload gear active. 13:27:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:27:50 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 13:27:50 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'] 13:27:50 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 13:27:51 INFO - (blobuploader) - INFO - Open directory for files ... 13:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:52 INFO - (blobuploader) - INFO - Done attempting. 13:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:52 INFO - (blobuploader) - INFO - Done attempting. 13:27:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:27:52 INFO - Return code: 0 13:27:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:27:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:27:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67637e74d571d55ed241808f180e48f4b7ef53428e725c57e8d200026cde40147dfe5fa9838242aa8c602132a0206a5c20169b075fea707d5a90fabcab89526f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea9e830605145750f587f14af0eebc1eca003dba68c5175608f15f6c17548e3082cb8df5c1588e91e1f100331969c8fc44dea0205e81376b0a203db8da27d8f"} 13:27:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:27:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:27:52 INFO - Contents: 13:27:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67637e74d571d55ed241808f180e48f4b7ef53428e725c57e8d200026cde40147dfe5fa9838242aa8c602132a0206a5c20169b075fea707d5a90fabcab89526f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea9e830605145750f587f14af0eebc1eca003dba68c5175608f15f6c17548e3082cb8df5c1588e91e1f100331969c8fc44dea0205e81376b0a203db8da27d8f"} 13:27:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:27:52 INFO - Copying logs to upload dir... 13:27:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:27:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.458201 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-13 13:27:51.200792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 13:27:51.204235) ========= 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=33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458 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/67637e74d571d55ed241808f180e48f4b7ef53428e725c57e8d200026cde40147dfe5fa9838242aa8c602132a0206a5c20169b075fea707d5a90fabcab89526f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea9e830605145750f587f14af0eebc1eca003dba68c5175608f15f6c17548e3082cb8df5c1588e91e1f100331969c8fc44dea0205e81376b0a203db8da27d8f"} build_url:https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/BwMB36YQR6K3uUB5l3-FCA/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/67637e74d571d55ed241808f180e48f4b7ef53428e725c57e8d200026cde40147dfe5fa9838242aa8c602132a0206a5c20169b075fea707d5a90fabcab89526f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea9e830605145750f587f14af0eebc1eca003dba68c5175608f15f6c17548e3082cb8df5c1588e91e1f100331969c8fc44dea0205e81376b0a203db8da27d8f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 13:27:51.228871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:27:51.229198) ========= 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=33d5923976266a1c518c4bf7000001ab-1463170032.598025-1518950458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:27:51.311172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 13:27:51.311495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 13:27:51.311778) ========= ========= Total master_lag: 0.25 =========