builder: larch_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1463803037.71 results: success (0) buildid: 20160520183008 builduid: 785bde8eac2a4f799a9bdfa199129e9c revision: 894f88d5f1062eb50ac67f4abd48f54d0ee8775b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.707120) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.707768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.708237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.755841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.756138) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 20:57:17-- 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% 31.5M=0s 2016-05-20 20:57:18 (31.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075983 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.853863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.854188) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016654 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.914312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:17.914669) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 894f88d5f1062eb50ac67f4abd48f54d0ee8775b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 894f88d5f1062eb50ac67f4abd48f54d0ee8775b --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=5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 20:57:18,141 truncating revision to first 12 chars 2016-05-20 20:57:18,141 Setting DEBUG logging. 2016-05-20 20:57:18,141 attempt 1/10 2016-05-20 20:57:18,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/894f88d5f106?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 20:57:18,399 unpacking tar archive at: larch-894f88d5f106/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545178 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:18.476179) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:18.476503) ========= script_repo_revision: 894f88d5f1062eb50ac67f4abd48f54d0ee8775b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:18.476882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:18.477145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 20:57:18.485739) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-20 20:57:18.486010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:57:18 INFO - MultiFileLogger online at 20160520 20:57:18 in /builds/slave/test 20:57:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 20:57:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:57:18 INFO - {'append_to_log': False, 20:57:18 INFO - 'base_work_dir': '/builds/slave/test', 20:57:18 INFO - 'blob_upload_branch': 'Larch', 20:57:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:57:18 INFO - 'branch': 'Larch', 20:57:18 INFO - 'buildbot_json_path': 'buildprops.json', 20:57:18 INFO - 'config_files': ('talos/linux_config.py',), 20:57:18 INFO - 'default_actions': ('clobber', 20:57:18 INFO - 'read-buildbot-config', 20:57:18 INFO - 'download-and-extract', 20:57:18 INFO - 'populate-webroot', 20:57:18 INFO - 'create-virtualenv', 20:57:18 INFO - 'install', 20:57:18 INFO - 'run-tests'), 20:57:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:57:18 INFO - 'download_minidump_stackwalk': True, 20:57:18 INFO - 'download_symbols': 'ondemand', 20:57:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:57:18 INFO - 'tooltool.py': '/tools/tooltool.py', 20:57:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:57:18 INFO - '/tools/misc-python/virtualenv.py')}, 20:57:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:57:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:57:18 INFO - 'installer_path': 'installer.exe', 20:57:18 INFO - 'log_level': 'info', 20:57:18 INFO - 'log_name': 'talos', 20:57:18 INFO - 'log_to_console': True, 20:57:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:57:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:57:18 INFO - 'opt_config_files': (), 20:57:18 INFO - 'pip_index': False, 20:57:18 INFO - 'sps_profile': False, 20:57:18 INFO - 'sps_profile_interval': 0, 20:57:18 INFO - 'suite': 'dromaeojs', 20:57:18 INFO - 'system_bits': '32', 20:57:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:57:18 INFO - 'title': 'talos-linux64-ix-051', 20:57:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:57:18 INFO - 'use_talos_json': True, 20:57:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:57:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:57:18 INFO - 'work_dir': 'build'} 20:57:18 INFO - ##### 20:57:18 INFO - ##### Running clobber step. 20:57:18 INFO - ##### 20:57:18 INFO - Running pre-action listener: _resource_record_pre_action 20:57:18 INFO - Running main action method: clobber 20:57:18 INFO - rmtree: /builds/slave/test/build 20:57:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:57:19 INFO - Running post-action listener: _resource_record_post_action 20:57:19 INFO - ##### 20:57:19 INFO - ##### Finished clobber step (success) 20:57:19 INFO - ##### 20:57:19 INFO - ##### 20:57:19 INFO - ##### Running read-buildbot-config step. 20:57:19 INFO - ##### 20:57:19 INFO - Running pre-action listener: _resource_record_pre_action 20:57:19 INFO - Running main action method: read_buildbot_config 20:57:19 INFO - Using buildbot properties: 20:57:19 INFO - { 20:57:19 INFO - "project": "", 20:57:19 INFO - "product": "firefox", 20:57:19 INFO - "script_repo_revision": "production", 20:57:19 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 20:57:19 INFO - "repository": "", 20:57:19 INFO - "buildername": "Ubuntu HW 12.04 x64 larch pgo talos dromaeojs", 20:57:19 INFO - "buildid": "20160520183008", 20:57:19 INFO - "pgo_build": "True", 20:57:19 INFO - "basedir": "/builds/slave/test", 20:57:19 INFO - "buildnumber": 1, 20:57:19 INFO - "slavename": "talos-linux64-ix-051", 20:57:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:57:19 INFO - "platform": "ubuntu64_hw", 20:57:19 INFO - "scheduler": "tests-larch-linux64-pgo-talos", 20:57:19 INFO - "branch": "larch", 20:57:19 INFO - "repo_path": "projects/larch", 20:57:19 INFO - "revision": "894f88d5f1062eb50ac67f4abd48f54d0ee8775b", 20:57:19 INFO - "stage_platform": "linux64-pgo", 20:57:19 INFO - "builduid": "785bde8eac2a4f799a9bdfa199129e9c", 20:57:19 INFO - "slavebuilddir": "test" 20:57:19 INFO - } 20:57:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:57:19 INFO - Running post-action listener: _resource_record_post_action 20:57:19 INFO - ##### 20:57:19 INFO - ##### Finished read-buildbot-config step (success) 20:57:19 INFO - ##### 20:57:19 INFO - ##### 20:57:19 INFO - ##### Running download-and-extract step. 20:57:19 INFO - ##### 20:57:19 INFO - Running pre-action listener: _resource_record_pre_action 20:57:19 INFO - Running main action method: download_and_extract 20:57:19 INFO - mkdir: /builds/slave/test/build/tests 20:57:19 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')]} 20:57:19 INFO - https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:57:19 INFO - Downloaded 1361 bytes. 20:57:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:57:19 INFO - Using the following test package requirements: 20:57:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:57:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:57:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:57:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'jsshell-linux-x86_64.zip'], 20:57:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:57:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:57:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:57:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:57:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:57:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:57:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:57:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:57:19 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')]} 20:57:19 INFO - https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:57:21 INFO - Downloaded 23902717 bytes. 20:57:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:57:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:57:22 INFO - Return code: 0 20:57:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:57:22 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')]} 20:57:22 INFO - https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:57:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:57:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:57:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:57:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:57:25 INFO - Downloaded 23902717 bytes. 20:57:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:57:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:57:27 INFO - Return code: 0 20:57: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')]} 20:57:27 INFO - https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:57:28 INFO - Downloaded 10840160 bytes. 20:57:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:57:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:57:28 INFO - Return code: 0 20:57:28 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')]} 20:57:28 INFO - https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:57:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:57:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:57:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:57:30 INFO - Downloaded 58397629 bytes. 20:57:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:57:30 INFO - mkdir: /builds/slave/test/properties 20:57:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:57:30 INFO - Writing to file /builds/slave/test/properties/build_url 20:57:30 INFO - Contents: 20:57:30 INFO - build_url:https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:57:30 INFO - Running post-action listener: _resource_record_post_action 20:57:30 INFO - Running post-action listener: set_extra_try_arguments 20:57:30 INFO - ##### 20:57:30 INFO - ##### Finished download-and-extract step (success) 20:57:30 INFO - ##### 20:57:30 INFO - ##### 20:57:30 INFO - ##### Running populate-webroot step. 20:57:30 INFO - ##### 20:57:30 INFO - Running pre-action listener: _resource_record_pre_action 20:57:30 INFO - Running main action method: populate_webroot 20:57:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:57:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:57:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:57:30 INFO - '--tppagecycles', 20:57:30 INFO - '7'], 20:57:30 INFO - 'tests': ['tsvgm']}}, 20:57:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:57:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:57:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:57:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:57:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['damp', 'tps']}, 20:57:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'tests': ['damp', 'tps']}, 20:57:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['dromaeo_dom']}, 20:57:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:57:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['a11yr', 20:57:30 INFO - 'ts_paint', 20:57:30 INFO - 'tpaint', 20:57:30 INFO - 'sessionrestore', 20:57:30 INFO - 'sessionrestore_no_auto_restore', 20:57:30 INFO - 'tabpaint']}, 20:57:30 INFO - 'other-e10s': {'tests': ['a11yr', 20:57:30 INFO - 'ts_paint', 20:57:30 INFO - 'tpaint', 20:57:30 INFO - 'sessionrestore', 20:57:30 INFO - 'sessionrestore_no_auto_restore', 20:57:30 INFO - 'tabpaint']}, 20:57:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:57:30 INFO - 'ts_paint', 20:57:30 INFO - 'tpaint', 20:57:30 INFO - 'sessionrestore', 20:57:30 INFO - 'sessionrestore_no_auto_restore', 20:57:30 INFO - 'tabpaint']}, 20:57:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:57:30 INFO - 'ts_paint', 20:57:30 INFO - 'tpaint', 20:57:30 INFO - 'sessionrestore', 20:57:30 INFO - 'sessionrestore_no_auto_restore', 20:57:30 INFO - 'tabpaint']}, 20:57:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['a11yr', 20:57:30 INFO - 'ts_paint', 20:57:30 INFO - 'tpaint', 20:57:30 INFO - 'sessionrestore', 20:57:30 INFO - 'sessionrestore_no_auto_restore', 20:57:30 INFO - 'tabpaint']}, 20:57:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['a11yr', 20:57:30 INFO - 'ts_paint', 20:57:30 INFO - 'tpaint', 20:57:30 INFO - 'sessionrestore', 20:57:30 INFO - 'sessionrestore_no_auto_restore', 20:57:30 INFO - 'tabpaint']}, 20:57:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['tsvgx', 20:57:30 INFO - 'tsvgr_opacity', 20:57:30 INFO - 'tart', 20:57:30 INFO - 'tscrollx', 20:57:30 INFO - 'cart']}, 20:57:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:57:30 INFO - 'tsvgr_opacity', 20:57:30 INFO - 'tart', 20:57:30 INFO - 'tscrollx', 20:57:30 INFO - 'cart']}, 20:57:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'talos_options': ['--disable-e10s'], 20:57:30 INFO - 'tests': ['tp5o']}, 20:57:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'tests': ['tp5o']}, 20:57:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'talos_options': ['--disable-e10s', 20:57:30 INFO - '--xperf_path', 20:57:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:30 INFO - 'tests': ['tp5n']}, 20:57:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:30 INFO - 'talos_options': ['--xperf_path', 20:57:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:30 INFO - 'tests': ['tp5n']}}, 20:57:30 INFO - 'talos.zip': {'path': '', 20:57:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:57:30 INFO - Running post-action listener: _resource_record_post_action 20:57:30 INFO - ##### 20:57:30 INFO - ##### Finished populate-webroot step (success) 20:57:30 INFO - ##### 20:57:30 INFO - ##### 20:57:30 INFO - ##### Running create-virtualenv step. 20:57:30 INFO - ##### 20:57:30 INFO - Running pre-action listener: _resource_record_pre_action 20:57:30 INFO - Running main action method: create_virtualenv 20:57:30 INFO - Creating virtualenv /builds/slave/test/build/venv 20:57:30 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 20:57:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:57:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:57:30 INFO - Using real prefix '/usr' 20:57:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:57:31 INFO - Installing distribute.............................................................................................................................................................................................done. 20:57:33 INFO - Installing pip.................done. 20:57:33 INFO - Return code: 0 20:57:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:57:33 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')]} 20:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:33 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')]} 20:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:33 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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:33 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 20:57:33 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 20:57:33 INFO - Using env: {'DISPLAY': ':0', 20:57:33 INFO - 'HOME': '/home/cltbld', 20:57:33 INFO - 'LANG': 'en_US.UTF-8', 20:57:33 INFO - 'LANGUAGE': 'en_US:en', 20:57:33 INFO - 'LOGNAME': 'cltbld', 20:57:33 INFO - 'MAIL': '/var/mail/cltbld', 20:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:33 INFO - 'MOZ_NO_REMOTE': '1', 20:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:33 INFO - 'NO_EM_RESTART': '1', 20:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:33 INFO - 'PWD': '/builds/slave/test', 20:57:33 INFO - 'SHELL': '/bin/bash', 20:57:33 INFO - 'SHLVL': '1', 20:57:33 INFO - 'TERM': 'linux', 20:57:33 INFO - 'TMOUT': '86400', 20:57:33 INFO - 'USER': 'cltbld', 20:57:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:33 INFO - '_': '/tools/buildbot/bin/python'} 20:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:33 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 20:57:33 INFO - Cleaning up... 20:57:33 INFO - Return code: 0 20:57:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:57:33 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')]} 20:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:33 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')]} 20:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:33 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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:33 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 20:57:33 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 20:57:33 INFO - Using env: {'DISPLAY': ':0', 20:57:33 INFO - 'HOME': '/home/cltbld', 20:57:33 INFO - 'LANG': 'en_US.UTF-8', 20:57:33 INFO - 'LANGUAGE': 'en_US:en', 20:57:33 INFO - 'LOGNAME': 'cltbld', 20:57:33 INFO - 'MAIL': '/var/mail/cltbld', 20:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:33 INFO - 'MOZ_NO_REMOTE': '1', 20:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:33 INFO - 'NO_EM_RESTART': '1', 20:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:33 INFO - 'PWD': '/builds/slave/test', 20:57:33 INFO - 'SHELL': '/bin/bash', 20:57:33 INFO - 'SHLVL': '1', 20:57:33 INFO - 'TERM': 'linux', 20:57:33 INFO - 'TMOUT': '86400', 20:57:33 INFO - 'USER': 'cltbld', 20:57:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:33 INFO - '_': '/tools/buildbot/bin/python'} 20:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:33 INFO - Downloading/unpacking psutil>=0.7.1 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:33 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 20:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:57:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:35 INFO - Installing collected packages: psutil 20:57:35 INFO - Running setup.py install for psutil 20:57:35 INFO - building 'psutil._psutil_linux' extension 20:57:35 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 20:57:36 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 20:57:36 INFO - building 'psutil._psutil_posix' extension 20:57:36 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 20:57:36 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 20:57:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:36 INFO - Successfully installed psutil 20:57:36 INFO - Cleaning up... 20:57:36 INFO - Return code: 0 20:57:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:36 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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:36 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 20:57:36 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 20:57:36 INFO - Using env: {'DISPLAY': ':0', 20:57:36 INFO - 'HOME': '/home/cltbld', 20:57:36 INFO - 'LANG': 'en_US.UTF-8', 20:57:36 INFO - 'LANGUAGE': 'en_US:en', 20:57:36 INFO - 'LOGNAME': 'cltbld', 20:57:36 INFO - 'MAIL': '/var/mail/cltbld', 20:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:36 INFO - 'MOZ_NO_REMOTE': '1', 20:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:36 INFO - 'NO_EM_RESTART': '1', 20:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:36 INFO - 'PWD': '/builds/slave/test', 20:57:36 INFO - 'SHELL': '/bin/bash', 20:57:36 INFO - 'SHLVL': '1', 20:57:36 INFO - 'TERM': 'linux', 20:57:36 INFO - 'TMOUT': '86400', 20:57:36 INFO - 'USER': 'cltbld', 20:57:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:36 INFO - '_': '/tools/buildbot/bin/python'} 20:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:57:36 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 20:57:36 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 20:57:36 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 20:57:36 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 20:57:36 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 20:57:36 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 20:57:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:57:38 INFO - Installing collected packages: mozsystemmonitor 20:57:38 INFO - Running setup.py install for mozsystemmonitor 20:57:38 INFO - Successfully installed mozsystemmonitor 20:57:38 INFO - Cleaning up... 20:57:38 INFO - Return code: 0 20:57:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:57:38 INFO - Using env: {'DISPLAY': ':0', 20:57:38 INFO - 'HOME': '/home/cltbld', 20:57:38 INFO - 'LANG': 'en_US.UTF-8', 20:57:38 INFO - 'LANGUAGE': 'en_US:en', 20:57:38 INFO - 'LOGNAME': 'cltbld', 20:57:38 INFO - 'MAIL': '/var/mail/cltbld', 20:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:38 INFO - 'MOZ_NO_REMOTE': '1', 20:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:38 INFO - 'NO_EM_RESTART': '1', 20:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:38 INFO - 'PWD': '/builds/slave/test', 20:57:38 INFO - 'SHELL': '/bin/bash', 20:57:38 INFO - 'SHLVL': '1', 20:57:38 INFO - 'TERM': 'linux', 20:57:38 INFO - 'TMOUT': '86400', 20:57:38 INFO - 'USER': 'cltbld', 20:57:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:38 INFO - '_': '/tools/buildbot/bin/python'} 20:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:40 INFO - Downloading blobuploader-1.2.4.tar.gz 20:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:57:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:57:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:41 INFO - Downloading docopt-0.6.1.tar.gz 20:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:57:41 INFO - Installing collected packages: blobuploader, requests, docopt 20:57:41 INFO - Running setup.py install for blobuploader 20:57:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:57:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:57:41 INFO - Running setup.py install for requests 20:57:41 INFO - Running setup.py install for docopt 20:57:42 INFO - Successfully installed blobuploader requests docopt 20:57:42 INFO - Cleaning up... 20:57:42 INFO - Return code: 0 20:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:42 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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:42 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 20:57:42 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 20:57:42 INFO - Using env: {'DISPLAY': ':0', 20:57:42 INFO - 'HOME': '/home/cltbld', 20:57:42 INFO - 'LANG': 'en_US.UTF-8', 20:57:42 INFO - 'LANGUAGE': 'en_US:en', 20:57:42 INFO - 'LOGNAME': 'cltbld', 20:57:42 INFO - 'MAIL': '/var/mail/cltbld', 20:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:42 INFO - 'MOZ_NO_REMOTE': '1', 20:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:42 INFO - 'NO_EM_RESTART': '1', 20:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:42 INFO - 'PWD': '/builds/slave/test', 20:57:42 INFO - 'SHELL': '/bin/bash', 20:57:42 INFO - 'SHLVL': '1', 20:57:42 INFO - 'TERM': 'linux', 20:57:42 INFO - 'TMOUT': '86400', 20:57:42 INFO - 'USER': 'cltbld', 20:57:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:42 INFO - '_': '/tools/buildbot/bin/python'} 20:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:42 INFO - Running setup.py (path:/tmp/pip-f84QBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:42 INFO - Running setup.py (path:/tmp/pip-wgjzYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:42 INFO - Running setup.py (path:/tmp/pip-nzsbvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:42 INFO - Running setup.py (path:/tmp/pip-MmwYEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:42 INFO - Running setup.py (path:/tmp/pip-bylL1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:42 INFO - Running setup.py (path:/tmp/pip-f2UBRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:42 INFO - Running setup.py (path:/tmp/pip-aEw358-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:42 INFO - Running setup.py (path:/tmp/pip-spCf8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:42 INFO - Running setup.py (path:/tmp/pip-B66Dlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:43 INFO - Running setup.py (path:/tmp/pip-pChdFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:43 INFO - Running setup.py (path:/tmp/pip-Xh7257-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:43 INFO - Running setup.py (path:/tmp/pip-_30paz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:43 INFO - Running setup.py (path:/tmp/pip-EBdOjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:43 INFO - Running setup.py (path:/tmp/pip-4CYyJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:43 INFO - Running setup.py (path:/tmp/pip-6sYtRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:43 INFO - Running setup.py (path:/tmp/pip-ZeC8MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:43 INFO - Running setup.py (path:/tmp/pip-E60a9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:57:43 INFO - Running setup.py install for manifestparser 20:57:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:57:43 INFO - Running setup.py install for mozcrash 20:57:43 INFO - Running setup.py install for mozdebug 20:57:43 INFO - Running setup.py install for mozdevice 20:57:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:57:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:57:43 INFO - Running setup.py install for mozfile 20:57:44 INFO - Running setup.py install for mozhttpd 20:57:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Running setup.py install for mozinfo 20:57:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Running setup.py install for mozInstall 20:57:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Running setup.py install for mozleak 20:57:44 INFO - Running setup.py install for mozlog 20:57:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Running setup.py install for moznetwork 20:57:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Running setup.py install for mozprocess 20:57:44 INFO - Running setup.py install for mozprofile 20:57:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:57:44 INFO - Running setup.py install for mozrunner 20:57:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:57:45 INFO - Running setup.py install for mozscreenshot 20:57:45 INFO - Running setup.py install for moztest 20:57:45 INFO - Running setup.py install for mozversion 20:57:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:57:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:57:45 INFO - Cleaning up... 20:57:45 INFO - Return code: 0 20:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:45 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')]} 20:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:45 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')]} 20:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:45 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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:45 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 20:57:45 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 20:57:45 INFO - Using env: {'DISPLAY': ':0', 20:57:45 INFO - 'HOME': '/home/cltbld', 20:57:45 INFO - 'LANG': 'en_US.UTF-8', 20:57:45 INFO - 'LANGUAGE': 'en_US:en', 20:57:45 INFO - 'LOGNAME': 'cltbld', 20:57:45 INFO - 'MAIL': '/var/mail/cltbld', 20:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:45 INFO - 'MOZ_NO_REMOTE': '1', 20:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:45 INFO - 'NO_EM_RESTART': '1', 20:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:45 INFO - 'PWD': '/builds/slave/test', 20:57:45 INFO - 'SHELL': '/bin/bash', 20:57:45 INFO - 'SHLVL': '1', 20:57:45 INFO - 'TERM': 'linux', 20:57:45 INFO - 'TMOUT': '86400', 20:57:45 INFO - 'USER': 'cltbld', 20:57:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:45 INFO - '_': '/tools/buildbot/bin/python'} 20:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:45 INFO - Running setup.py (path:/tmp/pip-pmzEFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:45 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)) 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:45 INFO - Running setup.py (path:/tmp/pip-BnG58I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:45 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)) 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:45 INFO - Running setup.py (path:/tmp/pip-Pwnf7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:45 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)) 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:45 INFO - Running setup.py (path:/tmp/pip-ymvZSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:45 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)) 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:45 INFO - Running setup.py (path:/tmp/pip-AZW_Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:45 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)) 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:45 INFO - Running setup.py (path:/tmp/pip-KtdIOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:46 INFO - Running setup.py (path:/tmp/pip-p3hYwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:46 INFO - Running setup.py (path:/tmp/pip-W2DYRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:46 INFO - Running setup.py (path:/tmp/pip-M8hZFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:46 INFO - Running setup.py (path:/tmp/pip-Hc960R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:46 INFO - Running setup.py (path:/tmp/pip-bWZq1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:46 INFO - Running setup.py (path:/tmp/pip-eXbOrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:46 INFO - Running setup.py (path:/tmp/pip-d42SNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:46 INFO - Running setup.py (path:/tmp/pip-trzjYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:46 INFO - Running setup.py (path:/tmp/pip-ik3jd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:46 INFO - Running setup.py (path:/tmp/pip-vVqDwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:46 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)) 20:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:46 INFO - Running setup.py (path:/tmp/pip-KM_5_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:46 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)) 20:57:46 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)) 20:57:46 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)) 20:57:46 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)) 20:57:46 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)) 20:57:46 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)) 20:57:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:48 INFO - Downloading blessings-1.6.tar.gz 20:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:57:48 INFO - Installing collected packages: blessings 20:57:48 INFO - Running setup.py install for blessings 20:57:48 INFO - Successfully installed blessings 20:57:48 INFO - Cleaning up... 20:57:48 INFO - Return code: 0 20:57:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:49 INFO - Reading from file tmpfile_stdout 20:57:49 INFO - Current package versions: 20:57:49 INFO - argparse == 1.2.1 20:57:49 INFO - blessings == 1.6 20:57:49 INFO - blobuploader == 1.2.4 20:57:49 INFO - docopt == 0.6.1 20:57:49 INFO - manifestparser == 1.1 20:57:49 INFO - mozInstall == 1.12 20:57:49 INFO - mozcrash == 0.17 20:57:49 INFO - mozdebug == 0.1 20:57:49 INFO - mozdevice == 0.48 20:57:49 INFO - mozfile == 1.2 20:57:49 INFO - mozhttpd == 0.7 20:57:49 INFO - mozinfo == 0.9 20:57:49 INFO - mozleak == 0.1 20:57:49 INFO - mozlog == 3.1 20:57:49 INFO - moznetwork == 0.27 20:57:49 INFO - mozprocess == 0.22 20:57:49 INFO - mozprofile == 0.28 20:57:49 INFO - mozrunner == 6.11 20:57:49 INFO - mozscreenshot == 0.1 20:57:49 INFO - mozsystemmonitor == 0.0 20:57:49 INFO - moztest == 0.7 20:57:49 INFO - mozversion == 1.4 20:57:49 INFO - psutil == 3.1.1 20:57:49 INFO - requests == 1.2.3 20:57:49 INFO - wsgiref == 0.1.2 20:57:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:49 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')]} 20:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:49 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')]} 20:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:49 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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:49 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 20:57:49 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 20:57:49 INFO - Using env: {'DISPLAY': ':0', 20:57:49 INFO - 'HOME': '/home/cltbld', 20:57:49 INFO - 'LANG': 'en_US.UTF-8', 20:57:49 INFO - 'LANGUAGE': 'en_US:en', 20:57:49 INFO - 'LOGNAME': 'cltbld', 20:57:49 INFO - 'MAIL': '/var/mail/cltbld', 20:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:49 INFO - 'MOZ_NO_REMOTE': '1', 20:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:49 INFO - 'NO_EM_RESTART': '1', 20:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:49 INFO - 'PWD': '/builds/slave/test', 20:57:49 INFO - 'SHELL': '/bin/bash', 20:57:49 INFO - 'SHLVL': '1', 20:57:49 INFO - 'TERM': 'linux', 20:57:49 INFO - 'TMOUT': '86400', 20:57:49 INFO - 'USER': 'cltbld', 20:57:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:49 INFO - '_': '/tools/buildbot/bin/python'} 20:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 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)) 20:57:49 INFO - Cleaning up... 20:57:49 INFO - Return code: 0 20:57:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:57:49 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')]} 20:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:49 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')]} 20:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:49 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 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:49 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 20:57:49 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 20:57:49 INFO - Using env: {'DISPLAY': ':0', 20:57:49 INFO - 'HOME': '/home/cltbld', 20:57:49 INFO - 'LANG': 'en_US.UTF-8', 20:57:49 INFO - 'LANGUAGE': 'en_US:en', 20:57:49 INFO - 'LOGNAME': 'cltbld', 20:57:49 INFO - 'MAIL': '/var/mail/cltbld', 20:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:49 INFO - 'MOZ_NO_REMOTE': '1', 20:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:49 INFO - 'NO_EM_RESTART': '1', 20:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:49 INFO - 'PWD': '/builds/slave/test', 20:57:49 INFO - 'SHELL': '/bin/bash', 20:57:49 INFO - 'SHLVL': '1', 20:57:49 INFO - 'TERM': 'linux', 20:57:49 INFO - 'TMOUT': '86400', 20:57:49 INFO - 'USER': 'cltbld', 20:57:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:49 INFO - '_': '/tools/buildbot/bin/python'} 20:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:49 INFO - Downloading/unpacking jsonschema 20:57:49 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 20:57:49 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 20:57:49 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 20:57:49 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 20:57:49 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 20:57:49 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 20:57:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:57:51 INFO - Downloading/unpacking functools32 (from jsonschema) 20:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:51 INFO - Downloading functools32-3.2.3-2.tar.gz 20:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:57:51 INFO - warning: no files found matching '*.txt' 20:57:51 INFO - no previously-included directories found matching 'build' 20:57:51 INFO - no previously-included directories found matching 'dist' 20:57:51 INFO - no previously-included directories found matching '.git*' 20:57:51 INFO - Installing collected packages: jsonschema, functools32 20:57:51 INFO - Running setup.py install for functools32 20:57:51 INFO - warning: no files found matching '*.txt' 20:57:51 INFO - no previously-included directories found matching 'build' 20:57:51 INFO - no previously-included directories found matching 'dist' 20:57:51 INFO - no previously-included directories found matching '.git*' 20:57:51 INFO - Successfully installed jsonschema functools32 20:57:51 INFO - Cleaning up... 20:57:51 INFO - Return code: 0 20:57:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:57: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')]} 20:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57: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')]} 20:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab13632f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', '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 20:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:57:51 INFO - Using env: {'DISPLAY': ':0', 20:57:51 INFO - 'HOME': '/home/cltbld', 20:57:51 INFO - 'LANG': 'en_US.UTF-8', 20:57:51 INFO - 'LANGUAGE': 'en_US:en', 20:57:51 INFO - 'LOGNAME': 'cltbld', 20:57:51 INFO - 'MAIL': '/var/mail/cltbld', 20:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:51 INFO - 'MOZ_NO_REMOTE': '1', 20:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:51 INFO - 'NO_EM_RESTART': '1', 20:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:51 INFO - 'PWD': '/builds/slave/test', 20:57:51 INFO - 'SHELL': '/bin/bash', 20:57:51 INFO - 'SHLVL': '1', 20:57:51 INFO - 'TERM': 'linux', 20:57:51 INFO - 'TMOUT': '86400', 20:57:51 INFO - 'USER': 'cltbld', 20:57:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:51 INFO - '_': '/tools/buildbot/bin/python'} 20:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:52 INFO - Downloading/unpacking flake8 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:57:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:57:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 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 20:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:57:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:57:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:57:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:57:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:57:54 INFO - no previously-included directories found matching 'docs/_build' 20:57:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:57:54 INFO - Running setup.py install for pep8 20:57:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:57:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:57:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:57:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:57:54 INFO - no previously-included directories found matching 'docs/_build' 20:57:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:57:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:57:54 INFO - Cleaning up... 20:57:54 INFO - Return code: 0 20:57:54 INFO - Running post-action listener: _resource_record_post_action 20:57:54 INFO - Running post-action listener: _start_resource_monitoring 20:57:55 INFO - Starting resource monitoring. 20:57:55 INFO - ##### 20:57:55 INFO - ##### Finished create-virtualenv step (success) 20:57:55 INFO - ##### 20:57:55 INFO - ##### 20:57:55 INFO - ##### Running install step. 20:57:55 INFO - ##### 20:57:55 INFO - Running pre-action listener: _resource_record_pre_action 20:57:55 INFO - Running main action method: install 20:57:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:55 INFO - Reading from file tmpfile_stdout 20:57:55 INFO - Detecting whether we're running mozinstall >=1.0... 20:57:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:57:55 INFO - Reading from file tmpfile_stdout 20:57:55 INFO - Output received: 20:57:55 INFO - Usage: mozinstall [options] installer 20:57:55 INFO - Options: 20:57:55 INFO - -h, --help show this help message and exit 20:57:55 INFO - -d DEST, --destination=DEST 20:57:55 INFO - Directory to install application into. [default: 20:57:55 INFO - "/builds/slave/test"] 20:57:55 INFO - --app=APP Application being installed. [default: firefox] 20:57:55 INFO - mkdir: /builds/slave/test/build/application 20:57:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:58:11 INFO - Reading from file tmpfile_stdout 20:58:11 INFO - Output received: 20:58:11 INFO - /builds/slave/test/build/application/firefox/firefox 20:58:11 INFO - Running post-action listener: _resource_record_post_action 20:58:11 INFO - ##### 20:58:11 INFO - ##### Finished install step (success) 20:58:11 INFO - ##### 20:58:11 INFO - ##### 20:58:11 INFO - ##### Running run-tests step. 20:58:11 INFO - ##### 20:58:11 INFO - Running pre-action listener: _resource_record_pre_action 20:58:11 INFO - Running main action method: run_tests 20:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:58:11 INFO - Python 2.7.3 20:58:11 INFO - Return code: 0 20:58:11 INFO - grabbing minidump binary from tooltool 20:58:11 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')]} 20:58:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11249c0>, '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 0x11258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:58:11 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 20:58:11 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 20:58:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:58:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:58:11 INFO - Return code: 0 20:58:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:58:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:58:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:58:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:58:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:58:12 INFO - Return code: 0 20:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:58:12 INFO - Using env: {'DISPLAY': ':0', 20:58:12 INFO - 'HOME': '/home/cltbld', 20:58:12 INFO - 'LANG': 'en_US.UTF-8', 20:58:12 INFO - 'LANGUAGE': 'en_US:en', 20:58:12 INFO - 'LOGNAME': 'cltbld', 20:58:12 INFO - 'MAIL': '/var/mail/cltbld', 20:58:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:58:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:12 INFO - 'MOZ_NO_REMOTE': '1', 20:58:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:12 INFO - 'NO_EM_RESTART': '1', 20:58:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:12 INFO - 'PWD': '/builds/slave/test', 20:58:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:58:12 INFO - 'SHELL': '/bin/bash', 20:58:12 INFO - 'SHLVL': '1', 20:58:12 INFO - 'TERM': 'linux', 20:58:12 INFO - 'TMOUT': '86400', 20:58:12 INFO - 'USER': 'cltbld', 20:58:12 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410', 20:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:12 INFO - '_': '/tools/buildbot/bin/python'} 20:58:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:58:13 INFO - mozversion application_buildid: 20160520183008 20:58:13 INFO - mozversion application_changeset: 894f88d5f1062eb50ac67f4abd48f54d0ee8775b 20:58:13 INFO - mozversion application_display_name: Nightly 20:58:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:58:13 INFO - mozversion application_name: Firefox 20:58:13 INFO - mozversion application_remotingname: firefox 20:58:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 20:58:13 INFO - mozversion application_vendor: Mozilla 20:58:13 INFO - mozversion application_version: 49.0a1 20:58:13 INFO - mozversion platform_buildid: 20160520183008 20:58:13 INFO - mozversion platform_changeset: 894f88d5f1062eb50ac67f4abd48f54d0ee8775b 20:58:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 20:58:13 INFO - mozversion platform_version: 49.0a1 20:58:13 INFO - using testdate: 1463803093 20:58:13 INFO - actual date: 1463803093 20:58:13 INFO - starting webserver on 'localhost:57337' 20:58:13 INFO - SUITE-START | Running 2 tests 20:58:13 INFO - TEST-START | dromaeo_css 20:58:13 INFO - operating with platform_type : linux_ 20:58:13 INFO - Initialising browser for dromaeo_css test... 20:58:13 INFO - TEST-INFO | started process 31625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Bj8ip/profile http://localhost:57337/getInfo.html) 20:58:16 INFO - PROCESS | 31625 | __metrics Screen width/height:1600/1200 20:58:16 INFO - PROCESS | 31625 | colorDepth:24 20:58:16 INFO - PROCESS | 31625 | Browser inner width/height: 1024/697 20:58:16 INFO - PROCESS | 31625 | __metrics 20:58:17 ERROR - PROCESS | 31625 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:58:18 INFO - TEST-INFO | 31625: exit 0 20:58:18 INFO - Browser initialized. 20:58:18 INFO - Running cycle 1/1 for dromaeo_css test... 20:58:18 INFO - TEST-INFO | started process 31704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Bj8ip/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:30 INFO - PROCESS | 31704 | RSS: Main: 152088576 20:58:30 INFO - PROCESS | 31704 | 20:59:21 INFO - PROCESS | 31704 | 1463803161392 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] 21:01:29 INFO - PROCESS | 31704 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57337/tests/dromaeo/cssquery-ext.html) 21:01:30 INFO - PROCESS | 31704 | RSS: Main: 276013056 21:01:30 INFO - PROCESS | 31704 | 21:04:33 INFO - PROCESS | 31704 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-ext.html (next: http://localhost:57337/tests/dromaeo/cssquery-jquery.html) 21:04:33 INFO - PROCESS | 31704 | RSS: Main: 236322816 21:04:33 INFO - PROCESS | 31704 | 21:07:35 INFO - PROCESS | 31704 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57337/tests/dromaeo/cssquery-mootools.html) 21:07:36 INFO - PROCESS | 31704 | RSS: Main: 245211136 21:07:36 INFO - PROCESS | 31704 | 21:10:38 INFO - PROCESS | 31704 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57337/tests/dromaeo/cssquery-prototype.html) 21:10:38 INFO - PROCESS | 31704 | RSS: Main: 235393024 21:10:38 INFO - PROCESS | 31704 | 21:13:41 INFO - PROCESS | 31704 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57337/tests/dromaeo/cssquery-yui.html) 21:13:42 INFO - PROCESS | 31704 | RSS: Main: 216662016 21:13:42 INFO - PROCESS | 31704 | 21:16:44 INFO - PROCESS | 31704 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-yui.html (next: http://localhost:57337/tests/dromaeo/cssquery-dojo.html) 21:16:45 INFO - PROCESS | 31704 | RSS: Main: 269287424 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | __start_tp_report 21:16:45 INFO - PROCESS | 31704 | _x_x_mozilla_page_load 21:16:45 INFO - PROCESS | 31704 | _x_x_mozilla_page_load_details 21:16:45 INFO - PROCESS | 31704 | |i|pagename|runs| 21:16:45 INFO - PROCESS | 31704 | |0;dojo.html;3149.9685003149975;3157.131788758092;3182.4908014717644;3184.3949649566594;3216.2602601401677;5263.789448422063;5358.6516876403;5362.0616392131415;5367.731613419333;5418;5364.061289274371;5369.62412631116;5422;5441.755121019553;5442.102053161234;4848.17581011229;4861.975690121553;5036.521530454601;5073.061483625541;5091.159958606825;4851.951480485185;5001.024800163969;5006.74966251686;5044.672096313746;5086.542211200991;4841.903161936759;4861.562459378655;4880.731559764212;4916.655834091615;4918.311436398907;4893.09477746618;4909.852704418873;4915.361003069578;4917.852464426073;4925.679830810986;4812.230043193107;4863.076015557032;4877.780499877514;4879.2925025871045;4931.506849315076;5355.6786592804165;5359.464053594648;5389.461053894618;5390.245365648812;5391.056565101092;5824.068149096167;5846.912296315516;5861.3552509223955;5868.354481007086;5877.9412205877825;5896.439838215363;5973.163757074013;5987.341392446828;5990.2212712347555;5995.460408563206;5516.117421212587;5541.750621222055;5544.112941929272;5594.58040646949;5601.663900165962;5841.707914604338;5980.312264089598;6049.243844519435;6056.515478761777;6073.180120683651;5833.533317334603;5845.532357411397;5907.911381329283;5913.615614985012;5914.0241860093465;5932.080527518242;5932.080527518242;5936.9406305937255;5965.880682386328;5986.012307969223;5631.465010823965;5767;5793.073108302736;5808.332041815161;5850.912236316459;5859.736311865976;5860.355360910296;5863.091220860773;5868.735906884201;5871.295444546682;4325.351197320427;4443.466783985942;4443.600075993176;4445.333200020023;4492.191405547033;3909.6285852844503;3924.803759811998;3940.2907476654477;3947.782871942013;3985.322495175827;5513.669179849222;5551.472610102034;5556.222128901957;5561.6663000220115;5563.415841336682;5704.258446401941;5818.738156782871;5911.497522710618;5917.46742793142;5919;5499.230107784913;5521.944780552143;5543;5544.584156188302;5596.692181929951;5038.067957427887;5050.292958985745;5053.31780209667;5056.544910958031;5101.132807422747;5941.762329506858;5975.25309336333;6039.245094363205;6073.18012068374;6084.756609735561;5897.351291358033;5901.409859014236;5910.320313163869;5913.497352725067;5916;6006.219191505076;6038.064100064497;6050;6050.6369617823075;6059.21230240066;5628.690422026828;5676.801311954062;5756.366799652119;5791.131330300489;5808.883822323445;5894.233749612523;5900.409959004065;5908.3205431375945;5913.674747888907;5928.110783382527;5741.8564535886935;5754.856128596819;5756.079027355603;5756.251687280626;5756.453136951983;5546.140348246028;5606.523445507014;5624;5635.605507614428;5677.261955945701;5508.44915508446;5526.640768350045;5541.6120871540215;5558.499735023867;5562.332520097614;5515.338159420895;5700.515456186271;5711;5757.8560535986935;5765.336986246635;5508.55931525485;5564.805231816867;5624.6625202487985;5644.153376993484;5665.03694371966 21:16:45 INFO - PROCESS | 31704 | |1;ext.html;580.6051884718393;625.893598088325;626.3454689849106;636.5703150373497;638.2245571630468;29966.55050174249;43027.78486107569;44072.55927440725;44083.338749918694;44092.55907440925;43302.13395732083;43482.34776478355;43515.564844351626;43524.78237608815;43632.34551481722;7915.920840791605;8777.2100510954;8908.910910890905;8909.821803563926;10299.897001030005;10041;10452.529636166391;10460.058594726474;10463.790724185512;10468.842967355497;10443.060124588785;10472.895271047306;10488.213383996193;10505.21210909181;10511.106555942753;8107.554084525378;10413;10451.895481045169;10687.198460115522;10692.732681682943;10586.894131058667;10618.840717389245;10619.20355973305;10651.946740266327;10668.199885008578;39724;40009.79995100035;40097.79951100255;40126.59873401258;40142.397864032064;3475.322312149132;3595.0473124621994;3596.1908570571672;3602.0814692253307;3631.5642122945414;31471.213219669462;31562.684373156204;31820.840895795372;32643.347133057207;32715;4363.869083927487;4408.977955110204;4417.955820441786;4433.024734558392;4444.35556844259;313660;315936;316523;316589;318795;58429.707851461324;58671.41328586745;58913.41086589165;59288.84978051495;59346.70326648339;61950.76098478005;62288.37711622917;62478.37521624816;62715;62799.778025526735;17119.315227391013;17760.111994400228;17800.109994500224;17809.287628494974;17813.910930445265;11953.163278570417;13369.398377073056;13557.457701691821;13615.046946713834;13898.166110033228;17083.91458042702;17518.562035949202;17569;17597.38409155699;17666;6148.1392605035335;6169.383061693795;6186.536009799283;6187;6397.328280530571;1070.5075665193942;1109.1348747976592;1128.1707944660668;1182.6865880541664;1248.2260998181187;31182;32034.19914502156;32104.83947580247;32221.677783222338;32395.190120246712;1156.8380426740264;1162.91859569831;1200.7058270723553;1213.3326670331282;1264.3994102801096;16783.664326713642;16987.575310617085;17274;17283;17294.913525432294;450130;454825;454911;456371;456419;56444;57023.14465283024;57285;57362.42637573654;57439.71280143572;1311.0691409099645;1404.39610967283;1442.7330943775435;1456.9781453278422;1467.4612919649066;30994.535081973336;32924.67075329216;32929.835350823094;33347.166320842174;33428.66571334353;50530.2420463686;51175;51233.48766512436;51423.48576514336;51429.48570514247;329842;334909.2072634232;335143;335620;336279;35692.82153589215;44132.55867441413;44861;45519.54480455153;49613;44031;44806.77596611996;45045.54954450545;49412.50587494223;49492.75253623709;40924.79537602293;42257.366139508544;42656.78671606622;43427.131457370044;44153.55846441623;41350;42182.78908605437;42273;42870.78564607157;43257;42140.78929605332;42709.14581708286;43171.78414107909;43368.132637347706;43369;35359.292814144086;36803.631963681095;37051;37220.25559488849;37613.43579846359;28209.858950705115;28721.425571488035;28887.5666864993;28903.42193156083;29078.854605726836 21:16:45 INFO - PROCESS | 31704 | |2;jquery.html;379.7575317748695;386.62883631713555;393.8030984507744;399.26077460543354;400.3134624119634;14302.642433939156;17275.481735547954;18182.272709091638;19977.200911963522;20025.499362515926;14951;17643.73534396985;18584.070796460157;18631.627367452642;19477.610447791034;5617.466340697637;5778.27771528559;5793.942060579404;5801.82594522165;5807.9419205808035;4131.772752498611;5714.942850571482;5763.221965034709;6005.3394126646035;6311.431971122598;6349.746010159588;6352.9364706353035;6353.968230158843;6368.29948705642;6376.394242546974;6135.141080248769;6331.683415829213;6332.05019247112;6339.778107766252;6362;5451.236826844245;5505.862353441156;5535.750891209906;5569.192467092249;5585.776568937237;22098.779012209994;22928.770712292997;23029.309120726404;23045.654315185286;23142.884285578464;2335.2877372401413;2407.626817843237;2451.8651474168914;2596.260065881215;2602.9349266268305;14319.284035798273;14344.211068391234;14360.56918292453;14454.855451445455;14570.271486425743;1945.620603982224;1951.3560525026708;1952.7461430014007;2064.917403303866;2109.7257356543705;79315.60342198309;85547.57226213891;86135;86658;88242.55878720565;10013.349132306377;10038.297319187734;10415.843762343571;10441;10570.207234457446;14049.157050576998;14106.506272280421;14146.787798183035;14149.151050936976;14180.787288190686;8204.179582041748;8572.657093716307;8621.224089831945;8719.60761765722;8734;7237.023001894782;8575.699850505202;8665;8768.868466973001;8799.868001979976;5919.55603329752;6291.496680265568;6482.319356467598;6513.348665133543;6533.314002029813;1855.3228071753983;1891.304890530988;1897.4023182697406;1959.5884864178681;1969.0351727653347;970.7573106723319;1077.1490522487304;1137.3176094343328;1144.3248483394837;1162.1574358589955;18359.17383717736;18653.626927461646;19181.520461988282;19212.327568535315;19538.413847584594;1012.7215015870695;1023.3757407981126;1023.9795204095876;1089.4334945828125;1098.1653943003216;9917.950410247902;10444.112250458644;10480.109190718722;10498.895011049792;10503.579856805794;214150;459485;471006;471085;472026;94431.52784236034;94882.52558737162;95923.52038239765;97257;97347;1073.849661047454;1088.9401082940356;1102.2890235797865;1110.1063643766845;1120.966371008871;16062.598435039217;16258.67482650364;16290.51128466148;16430.917845410695;16485.58786030359;38291.61708382992;38557;38720.80639596784;38763.41854872236;39143.30280366374;52435;55113.72443137919;56037.71981140068;56469.43530564642;56939.430605693415;8134.105248422788;8386.203310685476;8684.869726954226;11689.590864319707;12457;8302.70940517079;12309.322987235788;13460.798088028883;13819.930900345435;13966.860331396556;12662.176958497668;12736.172148810298;12878.742425151631;12895.226286422845;12980.545680901123;12097.879021209676;12290.262584244974;12402.441890114786;12596.496140154291;12767.042471814837;12877.227366358049;13040.54358097462;13076.542321018718;13187.274699891597;13268;13070.085094043327;13076.673083172996;13086.411111500196;13180.143290686075;13181.275029873066;12836.486540538273;12978.351082445652;13001.674958126123;13015.284159371326;13134.60596182116 21:16:45 INFO - PROCESS | 31704 | |3;mootools.html;1332.233965469855;1480.7630779075346;1521.650020495286;1656.6769479951415;1804.179098510178;8410.369222308329;8722.825543489127;8756.211940925323;8993.055729148427;9009.459432434041;8593.355498337634;8818.07410221927;8876.334274929373;8895.421797583153;8906.599203035863;2323.9302820915314;2341.1922886604093;2342.8360014798973;2346.507233480971;2349.2717257650097;2302.4359032037173;2319.5708793873187;2360.9173678921156;2367.7040369953756;2370.111208296889;2260.9434764130947;2294.5640328337563;2306.7577904320055;2339.2046704120594;2340.8127349812057;2216.9778302216932;2234.910603575855;2251.819854411643;2252.256755270765;2253.1663284584642;2200.19692812124;2203.162798136698;2205.6250437425674;2206.0403724379785;2208.182972300243;8712.172343627346;8824.823503529959;8898.288136949028;8902.065283145306;8984.820303593891;5278.366596008465;5367.141257398836;5388.676679399209;5396.244525766396;5415.539679127279;3424.743144264165;3448.0862571418593;3511.929761404783;3539.823008849573;3557;1063.500154927183;1100.4002818463875;1118.5973049702181;1145.8052131137642;1146.40386998761;12283.201591896499;12426.937865310616;12434.62696119118;12446.81329780054;12450.937745311216;4547.454305483297;4591.471980722193;4682.765861706901;4697.037107392976;4703.223968045303;9976.102150806317;9984.600615975425;9987.700368988943;9995;10001.949990250003;5187.714675692873;5187.870303242374;5196.558292545101;5209.322788037607;5224.190250511177;4313.9137217255475;4689.1559519286175;4803.78382972767;4908.803647854117;4913.680610760289;3949.822257998397;4014.237294913957;4084.9795751021056;4100.630943215125;4166.458360413127;1286.067600989294;1306.4839388441703;1313.4680454415977;1318.1168617026615;1332.0409305300168;804.9557274349967;886.423824514071;969.6266937229077;987.7674166197808;993;5712.80005199816;5720.399358067426;5974.880502389928;5994.0409534474275;6058.515318774487;948.0661548374845;984.2175470500969;1009.3035805294323;1019.97450063749;1046.3355769086684;3835.4055121456217;3924.9018774530864;3950.7036972227197;3967.0677390813134;4008.378701301303;10656.254062215725;11116.61091861781;11194.720131996764;11265.605703800327;11297.548098075986;10975;11088.5564577416;11140.944295278472;11145.888541114648;11147.832782508107;7857.449978501564;8247.298979586802;8321.16788321163;8354.164583541597;8362.623681934327;6014.248218972629;6029.728662210124;6112.969435152796;6118.510519158368;6179.907301390393;10184.694459166238;10221.284510084222;10357.482125893826;10377.117944974761;10458.163346932379;10430.843537347098;10530.842037369292;10535.63125290611;10638.468076596295;10662.84005739899;7883.605819709106;7950.204979502004;7982.481138726196;7986.680532778856;7991.160928102466;8514.106018868177;8587.87118193215;8658.870116948377;8671.566421679017;8745.125487451458;7921.722739704082;7953.085395179628;7982.84034319322;8023.157568455228;8052.83894322122;7759.92240077592;7783.455158139102;7881.330086942674;7882.132965373689;7928.127905930228;7135.5361901476235;7136.215016348301;7204.639768011683;7212.062431883822;7222.09723784527;4960.528749768766;5101.821436249714;5115.309433226466;5175.353080864892;5194.428612852659;4860.878478038077;4920.581750551243;5001.4998500149695;5074.5686616637995;5225.51072944209 21:16:45 INFO - PROCESS | 31704 | |4;prototype.html;339.8784012757899;342.4948201402931;345.3472936150675;347.42327735958315;348.7558708903766;5273.920891186631;5275.657082289648;5298.4436634153435;5300.522952934235;5336.998625515432;5234.895302093965;5250;5251.973740131303;5266.841994740154;5309.867253318659;3931.5478719947287;3997.860074897379;4117.3618089196225;4124.9587504124875;4132.318167502359;4069.7354671946377;4073.226087043467;4090.365993271048;4103.138340948404;4115.135821477494;3889.844406223762;4069.877903662895;4071.531773846016;4078.7348822326453;4089.548210385315;3958.4656071430422;4036.6568841648495;4089.345704687236;4123.154753275571;4136.73111247768;3619.927601447983;3660.7437479376454;3664.175560498893;3674.3386190485703;3698.8335524901445;5021.297018417425;5022.824201152978;5035.269885866565;5035.597152227813;5035.748212589356;4507.271877764853;4751.239801631757;4777;4777.641676874248;4782.402199725035;5446.2647542582035;5455.5908306877145;5478.616496845222;5507.339119305669;5509.972450137764;4044.4944381952255;4087.5299340575916;4093.692973027035;4098.262312783698;4106.609872062149;5616.971915140398;5642.181883626851;5679.460451257124;5688.317401911797;5746.626469279525;4024.269564087412;4076.470058892325;4087.9386809197886;4088.6729061674996;4114.238865809834;4144.611555129066;4167.958320416757;4171.249175148441;4179.226843034048;4179.6029377209115;4441;4664.370310008106;4691.366665500182;4724.551167639069;4734.857954261378;5477.945220547823;5495.505404513533;5496.230527726121;5504.146857237135;5551.834114835849;1407.3596513586294;1412.265621876639;1414.8514405987223;1418.638247246966;1422.2248874363497;910.4173329069268;916.1617120334952;929.3912487320681;934.275936149476;956.5647630328184;5316.73416329182;5326.97336513315;5338.8665283367445;5341.759620817073;5347.465253474621;5530.474604912527;5532.7786888524815;5539.390667026624;5556.166575013699;5590.440955904458;5026.246063090565;5247.035424984948;5266.2890509781455;5280.287161233261;5361.597880159004;2986.7909246352983;3022.6826183250882;3024.3346463777934;3045.8477076146105;3047.5885755422732;5783.768649253982;5838.678872662044;5850;5874.765009399576;5890.793822216202;5529.391766905637;5813.709314534256;5815.575184079928;5817.941820581825;5826.417358264224;5840.240768700041;5844.590878638454;5861.007257532459;5868.677222752704;5874.706264686834;5427.213054107211;5672.602917795714;5694.373618902;5696.572757043155;5757;5612.130119831432;5613.214150019082;5636.802711905064;5639.492445679908;5653;5839.802840417619;5879.735411906389;5958.493528049991;5962.25471816023;5996.070609055603;3904.4533765272317;4047.9797601011805;4053.8986525337104;4063.1264278180333;4077.266092103331;5648.830535083954;5744.856378590569;5770.711464426846;5788.479036886701;5810.331811841692;5331.973340133274;5393.8921221574565;5531.419200983839;5557.666540007613;5602.691851948182;5489.917651235314;5493.945060549343;5530.446955304437;5541.722913854211;5557.249771280987;5229.895402092013;5418.701971391612;5460.7542660579575;5480.150576660624;5490.149026900836;5546.972265138648;5560.666360018412;5579.911917176111;5582.162675598693;5595.216669666169;5374.570034397317;5425.918611220756;5456.809011684572;5495.560355171657;5498.3127109111365 21:16:45 INFO - PROCESS | 31704 | |5;yui.html;763.9388848892089;800.5676934455395;839.1524560194202;844.8056946902212;856.3235044314991;14444.783328250085;15072.623184420396;15101.471448499306;15109.546713598582;15155.772663410058;13134.21194728317;13247.933760331209;13257.668558286023;13272.20366777994;13280.535181268633;668.862883108964;799.3964556759638;812.6140083460339;829.5022986208257;829.8589239829244;829.7593697827623;830.2735106781566;833.0586437325813;833.5457175839152;838.5765188579759;882.1927935938609;884.3455842676406;884.6682494064726;884.7743825324566;885.3802338363139;726.4733068525329;854.8674955381895;866.0906048648957;873.9344549158839;876.1413814461863;645.5997281685385;646.6217262901208;647.1166857239881;647.3429469088878;647.3558808985043;12851.935740321333;12855.74288514234;12862.970962322992;12864.421101050475;12930.224186548838;12585.181963172365;12598.055145864097;13022.869771302356;13554;13823.654408639864;10103.393796372242;10104.646337378157;10283.897161028368;12077.57728479499;12511.311877846714;4485.686001979862;4532.184206842767;4580.770961451914;4609.367585576508;4660.091282199973;52959.73520132413;53261.467385326425;53807.73096134494;54197;54387.456125438635;10983.231173817756;11070.612528561624;11181.496832642551;11230.775384492428;11309.773804523864;18491.352802651843;18502.44492665195;18514;18799;18827.905860470884;7876;8007.319377852831;8114.107448180695;8223.629936652746;8334.70828521011;4540.931886021713;4586.587207151372;4678.7660616969015;4734.124187025412;4934.259861020804;3311.089450401159;3425.7773244739014;3426.417509023472;3426.674465925733;3429.8456569454434;652.9902051469231;660.6531570925303;663.6515829189617;672.4586707700348;672.9966350168218;701.7859552836331;707.2361849202952;730.4667592657283;741.0625558668289;756.3608750605729;8736.257418119403;8771.517566533774;8775.868361974575;8810.383273170817;9112.316576256808;580.5181699189662;711.345562082885;735.3675838778646;765.9195784442553;772.6754762999553;4387.736735795863;4420.292753159543;4468.191817418879;4609.723416594948;4740.525947405232;67841.66079169573;68551.65724171347;71345.28654713386;71471.2852871475;71801;59871.40128598746;61129.38870611326;61469.38530614726;62163.37836621666;62724.372756271856;55142.17286740622;55862.72068639631;56191.71904140453;56681.7165914176;56909.14636280542;8668.696595619123;8772.868406973774;8896.911030889609;8993.838607405469;9059.637614495346;33329.83335083406;33419.16452088717;33547.496787547716;34224;35138;43404.78297608492;44104.558954410044;44272.778636107905;44569.55430445784;44682.41469816273;11654.650360489199;11768.35274059935;11917.94041029824;12810.359482026048;12954.639762824767;13827.585172444842;14102.123291425758;14262.786058209344;14332.211728355041;14547.709045819236;13233.602991910258;13416.39626216842;13579.388927498483;13997.790033149307;14196.574102776933;13175.341232938506;13471;13802.585922422344;13863.79204311916;14123.081999669988;12506.874931250572;12673.429695663533;12773.23360598367;12908.870911290767;13220.867791321964;11036.337819730841;11102.777944441228;11242.437878105899;11340.432978350884;11569.768604627692;11078.390688512209;11268.323900565993;11365.008708149757;11461.942690286494;11558.190926635054 21:16:45 INFO - PROCESS | 31704 | __end_tp_report 21:16:45 INFO - PROCESS | 31704 | __start_cc_report 21:16:45 INFO - PROCESS | 31704 | _x_x_mozilla_cycle_collect,1004 21:16:45 INFO - PROCESS | 31704 | __end_cc_report 21:16:45 INFO - PROCESS | 31704 | __startTimestamp1463804205109__endTimestamp 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | ------- Summary: start ------- 21:16:45 INFO - PROCESS | 31704 | Number of tests: 6 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | [#0] dojo.html Cycles:165 Average:5424.53 Median:5596.69 stddev:631.85 (11.3%) stddev-sans-first:608.07 21:16:45 INFO - PROCESS | 31704 | Values: 3150.0 3157.1 3182.5 3184.4 3216.3 5263.8 5358.7 5362.1 5367.7 5418.0 5364.1 5369.6 5422.0 5441.8 5442.1 4848.2 4862.0 5036.5 5073.1 5091.2 4852.0 5001.0 5006.7 5044.7 5086.5 4841.9 4861.6 4880.7 4916.7 4918.3 4893.1 4909.9 4915.4 4917.9 4925.7 4812.2 4863.1 4877.8 4879.3 4931.5 5355.7 5359.5 5389.5 5390.2 5391.1 5824.1 5846.9 5861.4 5868.4 5877.9 5896.4 5973.2 5987.3 5990.2 5995.5 5516.1 5541.8 5544.1 5594.6 5601.7 5841.7 5980.3 6049.2 6056.5 6073.2 5833.5 5845.5 5907.9 5913.6 5914.0 5932.1 5932.1 5936.9 5965.9 5986.0 5631.5 5767.0 5793.1 5808.3 5850.9 5859.7 5860.4 5863.1 5868.7 5871.3 4325.4 4443.5 4443.6 4445.3 4492.2 3909.6 3924.8 3940.3 3947.8 3985.3 5513.7 5551.5 5556.2 5561.7 5563.4 5704.3 5818.7 5911.5 5917.5 5919.0 5499.2 5521.9 5543.0 5544.6 5596.7 5038.1 5050.3 5053.3 5056.5 5101.1 5941.8 5975.3 6039.2 6073.2 6084.8 5897.4 5901.4 5910.3 5913.5 5916.0 6006.2 6038.1 6050.0 6050.6 6059.2 5628.7 5676.8 5756.4 5791.1 5808.9 5894.2 5900.4 5908.3 5913.7 5928.1 5741.9 5754.9 5756.1 5756.3 5756.5 5546.1 5606.5 5624.0 5635.6 5677.3 5508.4 5526.6 5541.6 5558.5 5562.3 5515.3 5700.5 5711.0 5757.9 5765.3 5508.6 5564.8 5624.7 5644.2 5665.0 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | [#1] ext.html Cycles:180 Average:54859.33 Median:3599.14 stddev:98188.28 (2728.1%) stddev-sans-first:98379.14 21:16:45 INFO - PROCESS | 31704 | Values: 580.6 625.9 626.3 636.6 638.2 29966.6 43027.8 44072.6 44083.3 44092.6 43302.1 43482.3 43515.6 43524.8 43632.3 7915.9 8777.2 8908.9 8909.8 10299.9 10041.0 10452.5 10460.1 10463.8 10468.8 10443.1 10472.9 10488.2 10505.2 10511.1 8107.6 10413.0 10451.9 10687.2 10692.7 10586.9 10618.8 10619.2 10651.9 10668.2 39724.0 40009.8 40097.8 40126.6 40142.4 3475.3 3595.0 3596.2 3602.1 3631.6 31471.2 31562.7 31820.8 32643.3 32715.0 4363.9 4409.0 4418.0 4433.0 4444.4 313660.0 315936.0 316523.0 316589.0 318795.0 58429.7 58671.4 58913.4 59288.8 59346.7 61950.8 62288.4 62478.4 62715.0 62799.8 17119.3 17760.1 17800.1 17809.3 17813.9 11953.2 13369.4 13557.5 13615.0 13898.2 17083.9 17518.6 17569.0 17597.4 17666.0 6148.1 6169.4 6186.5 6187.0 6397.3 1070.5 1109.1 1128.2 1182.7 1248.2 31182.0 32034.2 32104.8 32221.7 32395.2 1156.8 1162.9 1200.7 1213.3 1264.4 16783.7 16987.6 17274.0 17283.0 17294.9 450130.0 454825.0 454911.0 456371.0 456419.0 56444.0 57023.1 57285.0 57362.4 57439.7 1311.1 1404.4 1442.7 1457.0 1467.5 30994.5 32924.7 32929.8 33347.2 33428.7 50530.2 51175.0 51233.5 51423.5 51429.5 329842.0 334909.2 335143.0 335620.0 336279.0 35692.8 44132.6 44861.0 45519.5 49613.0 44031.0 44806.8 45045.5 49412.5 49492.8 40924.8 42257.4 42656.8 43427.1 44153.6 41350.0 42182.8 42273.0 42870.8 43257.0 42140.8 42709.1 43171.8 43368.1 43369.0 35359.3 36803.6 37051.0 37220.3 37613.4 28209.9 28721.4 28887.6 28903.4 29078.9 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | [#2] jquery.html Cycles:180 Average:27376.49 Median:20001.35 stddev:71430.45 (357.1%) stddev-sans-first:71602.07 21:16:45 INFO - PROCESS | 31704 | Values: 379.8 386.6 393.8 399.3 400.3 14302.6 17275.5 18182.3 19977.2 20025.5 14951.0 17643.7 18584.1 18631.6 19477.6 5617.5 5778.3 5793.9 5801.8 5807.9 4131.8 5714.9 5763.2 6005.3 6311.4 6349.7 6352.9 6354.0 6368.3 6376.4 6135.1 6331.7 6332.1 6339.8 6362.0 5451.2 5505.9 5535.8 5569.2 5585.8 22098.8 22928.8 23029.3 23045.7 23142.9 2335.3 2407.6 2451.9 2596.3 2602.9 14319.3 14344.2 14360.6 14454.9 14570.3 1945.6 1951.4 1952.7 2064.9 2109.7 79315.6 85547.6 86135.0 86658.0 88242.6 10013.3 10038.3 10415.8 10441.0 10570.2 14049.2 14106.5 14146.8 14149.2 14180.8 8204.2 8572.7 8621.2 8719.6 8734.0 7237.0 8575.7 8665.0 8768.9 8799.9 5919.6 6291.5 6482.3 6513.3 6533.3 1855.3 1891.3 1897.4 1959.6 1969.0 970.8 1077.1 1137.3 1144.3 1162.2 18359.2 18653.6 19181.5 19212.3 19538.4 1012.7 1023.4 1024.0 1089.4 1098.2 9918.0 10444.1 10480.1 10498.9 10503.6 214150.0 459485.0 471006.0 471085.0 472026.0 94431.5 94882.5 95923.5 97257.0 97347.0 1073.8 1088.9 1102.3 1110.1 1121.0 16062.6 16258.7 16290.5 16430.9 16485.6 38291.6 38557.0 38720.8 38763.4 39143.3 52435.0 55113.7 56037.7 56469.4 56939.4 8134.1 8386.2 8684.9 11689.6 12457.0 8302.7 12309.3 13460.8 13819.9 13966.9 12662.2 12736.2 12878.7 12895.2 12980.5 12097.9 12290.3 12402.4 12596.5 12767.0 12877.2 13040.5 13076.5 13187.3 13268.0 13070.1 13076.7 13086.4 13180.1 13181.3 12836.5 12978.4 13001.7 13015.3 13134.6 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | [#3] mootools.html Cycles:180 Average:5852.34 Median:4753.50 stddev:3351.76 (70.5%) stddev-sans-first:3343.95 21:16:45 INFO - PROCESS | 31704 | Values: 1332.2 1480.8 1521.7 1656.7 1804.2 8410.4 8722.8 8756.2 8993.1 9009.5 8593.4 8818.1 8876.3 8895.4 8906.6 2323.9 2341.2 2342.8 2346.5 2349.3 2302.4 2319.6 2360.9 2367.7 2370.1 2260.9 2294.6 2306.8 2339.2 2340.8 2217.0 2234.9 2251.8 2252.3 2253.2 2200.2 2203.2 2205.6 2206.0 2208.2 8712.2 8824.8 8898.3 8902.1 8984.8 5278.4 5367.1 5388.7 5396.2 5415.5 3424.7 3448.1 3511.9 3539.8 3557.0 1063.5 1100.4 1118.6 1145.8 1146.4 12283.2 12426.9 12434.6 12446.8 12450.9 4547.5 4591.5 4682.8 4697.0 4703.2 9976.1 9984.6 9987.7 9995.0 10001.9 5187.7 5187.9 5196.6 5209.3 5224.2 4313.9 4689.2 4803.8 4908.8 4913.7 3949.8 4014.2 4085.0 4100.6 4166.5 1286.1 1306.5 1313.5 1318.1 1332.0 805.0 886.4 969.6 987.8 993.0 5712.8 5720.4 5974.9 5994.0 6058.5 948.1 984.2 1009.3 1020.0 1046.3 3835.4 3924.9 3950.7 3967.1 4008.4 10656.3 11116.6 11194.7 11265.6 11297.5 10975.0 11088.6 11140.9 11145.9 11147.8 7857.4 8247.3 8321.2 8354.2 8362.6 6014.2 6029.7 6113.0 6118.5 6179.9 10184.7 10221.3 10357.5 10377.1 10458.2 10430.8 10530.8 10535.6 10638.5 10662.8 7883.6 7950.2 7982.5 7986.7 7991.2 8514.1 8587.9 8658.9 8671.6 8745.1 7921.7 7953.1 7982.8 8023.2 8052.8 7759.9 7783.5 7881.3 7882.1 7928.1 7135.5 7136.2 7204.6 7212.1 7222.1 4960.5 5101.8 5115.3 5175.4 5194.4 4860.9 4920.6 5001.5 5074.6 5225.5 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | [#4] prototype.html Cycles:180 Average:4655.90 Median:5329.47 stddev:1365.10 (25.6%) stddev-sans-first:1329.94 21:16:45 INFO - PROCESS | 31704 | Values: 339.9 342.5 345.3 347.4 348.8 5273.9 5275.7 5298.4 5300.5 5337.0 5234.9 5250.0 5252.0 5266.8 5309.9 3931.5 3997.9 4117.4 4125.0 4132.3 4069.7 4073.2 4090.4 4103.1 4115.1 3889.8 4069.9 4071.5 4078.7 4089.5 3958.5 4036.7 4089.3 4123.2 4136.7 3619.9 3660.7 3664.2 3674.3 3698.8 5021.3 5022.8 5035.3 5035.6 5035.7 4507.3 4751.2 4777.0 4777.6 4782.4 5446.3 5455.6 5478.6 5507.3 5510.0 4044.5 4087.5 4093.7 4098.3 4106.6 5617.0 5642.2 5679.5 5688.3 5746.6 4024.3 4076.5 4087.9 4088.7 4114.2 4144.6 4168.0 4171.2 4179.2 4179.6 4441.0 4664.4 4691.4 4724.6 4734.9 5477.9 5495.5 5496.2 5504.1 5551.8 1407.4 1412.3 1414.9 1418.6 1422.2 910.4 916.2 929.4 934.3 956.6 5316.7 5327.0 5338.9 5341.8 5347.5 5530.5 5532.8 5539.4 5556.2 5590.4 5026.2 5247.0 5266.3 5280.3 5361.6 2986.8 3022.7 3024.3 3045.8 3047.6 5783.8 5838.7 5850.0 5874.8 5890.8 5529.4 5813.7 5815.6 5817.9 5826.4 5840.2 5844.6 5861.0 5868.7 5874.7 5427.2 5672.6 5694.4 5696.6 5757.0 5612.1 5613.2 5636.8 5639.5 5653.0 5839.8 5879.7 5958.5 5962.3 5996.1 3904.5 4048.0 4053.9 4063.1 4077.3 5648.8 5744.9 5770.7 5788.5 5810.3 5332.0 5393.9 5531.4 5557.7 5602.7 5489.9 5493.9 5530.4 5541.7 5557.2 5229.9 5418.7 5460.8 5480.2 5490.1 5547.0 5560.7 5579.9 5582.2 5595.2 5374.6 5425.9 5456.8 5495.6 5498.3 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - PROCESS | 31704 | [#5] yui.html Cycles:180 Average:15385.31 Median:4560.85 stddev:18397.70 (403.4%) stddev-sans-first:18416.55 21:16:45 INFO - PROCESS | 31704 | Values: 763.9 800.6 839.2 844.8 856.3 14444.8 15072.6 15101.5 15109.5 15155.8 13134.2 13247.9 13257.7 13272.2 13280.5 668.9 799.4 812.6 829.5 829.9 829.8 830.3 833.1 833.5 838.6 882.2 884.3 884.7 884.8 885.4 726.5 854.9 866.1 873.9 876.1 645.6 646.6 647.1 647.3 647.4 12851.9 12855.7 12863.0 12864.4 12930.2 12585.2 12598.1 13022.9 13554.0 13823.7 10103.4 10104.6 10283.9 12077.6 12511.3 4485.7 4532.2 4580.8 4609.4 4660.1 52959.7 53261.5 53807.7 54197.0 54387.5 10983.2 11070.6 11181.5 11230.8 11309.8 18491.4 18502.4 18514.0 18799.0 18827.9 7876.0 8007.3 8114.1 8223.6 8334.7 4540.9 4586.6 4678.8 4734.1 4934.3 3311.1 3425.8 3426.4 3426.7 3429.8 653.0 660.7 663.7 672.5 673.0 701.8 707.2 730.5 741.1 756.4 8736.3 8771.5 8775.9 8810.4 9112.3 580.5 711.3 735.4 765.9 772.7 4387.7 4420.3 4468.2 4609.7 4740.5 67841.7 68551.7 71345.3 71471.3 71801.0 59871.4 61129.4 61469.4 62163.4 62724.4 55142.2 55862.7 56191.7 56681.7 56909.1 8668.7 8772.9 8896.9 8993.8 9059.6 33329.8 33419.2 33547.5 34224.0 35138.0 43404.8 44104.6 44272.8 44569.6 44682.4 11654.7 11768.4 11917.9 12810.4 12954.6 13827.6 14102.1 14262.8 14332.2 14547.7 13233.6 13416.4 13579.4 13997.8 14196.6 13175.3 13471.0 13802.6 13863.8 14123.1 12506.9 12673.4 12773.2 12908.9 13220.9 11036.3 11102.8 11242.4 11340.4 11569.8 11078.4 11268.3 11365.0 11461.9 11558.2 21:16:45 INFO - PROCESS | 31704 | -------- Summary: end -------- 21:16:45 INFO - PROCESS | 31704 | 21:16:45 INFO - TEST-INFO | 31704: exit 0 21:16:45 INFO - TEST-OK | dromaeo_css | took 1112713ms 21:16:45 INFO - TEST-START | kraken 21:16:45 INFO - operating with platform_type : linux_ 21:16:45 INFO - Initialising browser for kraken test... 21:16:45 INFO - TEST-INFO | started process 31887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKoiRu/profile http://localhost:57337/getInfo.html) 21:16:49 INFO - PROCESS | 31887 | __metrics Screen width/height:1600/1200 21:16:49 INFO - PROCESS | 31887 | colorDepth:24 21:16:49 INFO - PROCESS | 31887 | Browser inner width/height: 1024/697 21:16:49 INFO - PROCESS | 31887 | __metrics 21:16:50 ERROR - PROCESS | 31887 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:16:51 INFO - TEST-INFO | 31887: exit 0 21:16:51 INFO - Browser initialized. 21:16:51 INFO - Running cycle 1/1 for kraken test... 21:16:51 INFO - TEST-INFO | started process 31966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKoiRu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:17:03 INFO - PROCESS | 31966 | RSS: Main: 152616960 21:17:03 INFO - PROCESS | 31966 | 21:17:05 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-beat-detection) 21:17:06 INFO - PROCESS | 31966 | RSS: Main: 208007168 21:17:06 INFO - PROCESS | 31966 | 21:17:09 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-dft) 21:17:10 INFO - PROCESS | 31966 | RSS: Main: 196104192 21:17:10 INFO - PROCESS | 31966 | 21:17:13 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-fft) 21:17:13 INFO - PROCESS | 31966 | RSS: Main: 265007104 21:17:13 INFO - PROCESS | 31966 | 21:17:16 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-oscillator) 21:17:16 INFO - PROCESS | 31966 | RSS: Main: 174358528 21:17:16 INFO - PROCESS | 31966 | 21:17:18 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:17:19 INFO - PROCESS | 31966 | RSS: Main: 178466816 21:17:19 INFO - PROCESS | 31966 | 21:17:22 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57337/tests/kraken/driver.html?testName=imaging-darkroom) 21:17:23 INFO - PROCESS | 31966 | RSS: Main: 213970944 21:17:23 INFO - PROCESS | 31966 | 21:17:26 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57337/tests/kraken/driver.html?testName=imaging-desaturate) 21:17:27 INFO - PROCESS | 31966 | RSS: Main: 212217856 21:17:27 INFO - PROCESS | 31966 | 21:17:30 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57337/tests/kraken/driver.html?testName=json-parse-financial) 21:17:31 INFO - PROCESS | 31966 | RSS: Main: 213041152 21:17:31 INFO - PROCESS | 31966 | 21:17:32 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:17:33 INFO - PROCESS | 31966 | RSS: Main: 201138176 21:17:33 INFO - PROCESS | 31966 | 21:17:35 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:17:35 INFO - PROCESS | 31966 | RSS: Main: 204529664 21:17:35 INFO - PROCESS | 31966 | 21:17:37 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:17:38 INFO - PROCESS | 31966 | RSS: Main: 214953984 21:17:38 INFO - PROCESS | 31966 | 21:17:41 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:17:41 INFO - PROCESS | 31966 | RSS: Main: 223236096 21:17:41 INFO - PROCESS | 31966 | 21:17:44 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:17:45 INFO - PROCESS | 31966 | RSS: Main: 218992640 21:17:45 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57337/tests/kraken/driver.html?testName=ai-astar) 21:17:47 INFO - PROCESS | 31966 | RSS: Main: 263888896 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | __start_tp_report 21:17:47 INFO - PROCESS | 31966 | _x_x_mozilla_page_load 21:17:47 INFO - PROCESS | 31966 | _x_x_mozilla_page_load_details 21:17:47 INFO - PROCESS | 31966 | |i|pagename|runs| 21:17:47 INFO - PROCESS | 31966 | |0;ai-astar;110;105;111;110;110;112;109;110;109;111 21:17:47 INFO - PROCESS | 31966 | |1;audio-beat-detection;157;124;161;203;133;150;151;125;198;123 21:17:47 INFO - PROCESS | 31966 | |2;audio-dft;162;161;160;161;162;161;161;161;161;159 21:17:47 INFO - PROCESS | 31966 | |3;audio-fft;75;77;76;146;76;76;76;76;142;76 21:17:47 INFO - PROCESS | 31966 | |4;audio-oscillator;92;91;155;93;91;91;126;91;91;122 21:17:47 INFO - PROCESS | 31966 | |5;imaging-gaussian-blur;116;118;116;117;117;117;117;116;117;117 21:17:47 INFO - PROCESS | 31966 | |6;imaging-darkroom;145;145;145;146;144;145;145;146;146;145 21:17:47 INFO - PROCESS | 31966 | |7;imaging-desaturate;94;95;95;94;94;94;94;95;94;94 21:17:47 INFO - PROCESS | 31966 | |8;json-parse-financial;57;59;65;58;58;56;56;109;54;57 21:17:47 INFO - PROCESS | 31966 | |9;json-stringify-tinderbox;58;59;59;58;59;58;59;59;59;59 21:17:47 INFO - PROCESS | 31966 | |10;stanford-crypto-aes;80;79;79;80;80;85;80;79;86;85 21:17:47 INFO - PROCESS | 31966 | |11;stanford-crypto-ccm;127;125;124;126;122;130;121;131;189;125 21:17:47 INFO - PROCESS | 31966 | |12;stanford-crypto-pbkdf2;167;171;166;166;166;170;169;172;170;166 21:17:47 INFO - PROCESS | 31966 | |13;stanford-crypto-sha256-iterative;68;64;68;64;65;68;69;65;62;67 21:17:47 INFO - PROCESS | 31966 | __end_tp_report 21:17:47 INFO - PROCESS | 31966 | __start_cc_report 21:17:47 INFO - PROCESS | 31966 | _x_x_mozilla_cycle_collect,1825 21:17:47 INFO - PROCESS | 31966 | __end_cc_report 21:17:47 INFO - PROCESS | 31966 | __startTimestamp1463804267265__endTimestamp 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | ------- Summary: start ------- 21:17:47 INFO - PROCESS | 31966 | Number of tests: 14 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:2.00 21:17:47 INFO - PROCESS | 31966 | Values: 110.0 105.0 111.0 110.0 110.0 112.0 109.0 110.0 109.0 111.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:154.00 stddev:28.95 (18.8%) stddev-sans-first:30.66 21:17:47 INFO - PROCESS | 31966 | Values: 157.0 124.0 161.0 203.0 133.0 150.0 151.0 125.0 198.0 123.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 21:17:47 INFO - PROCESS | 31966 | Values: 162.0 161.0 160.0 161.0 162.0 161.0 161.0 161.0 161.0 159.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#3] audio-fft Cycles:10 Average:89.60 Median:76.00 stddev:28.69 (37.8%) stddev-sans-first:29.94 21:17:47 INFO - PROCESS | 31966 | Values: 75.0 77.0 76.0 146.0 76.0 76.0 76.0 76.0 142.0 76.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:91.00 stddev:22.41 (24.6%) stddev-sans-first:23.32 21:17:47 INFO - PROCESS | 31966 | Values: 92.0 91.0 155.0 93.0 91.0 91.0 126.0 91.0 91.0 122.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 21:17:47 INFO - PROCESS | 31966 | Values: 116.0 118.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:17:47 INFO - PROCESS | 31966 | Values: 145.0 145.0 145.0 146.0 144.0 145.0 145.0 146.0 146.0 145.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:17:47 INFO - PROCESS | 31966 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:57.50 stddev:16.45 (28.6%) stddev-sans-first:17.31 21:17:47 INFO - PROCESS | 31966 | Values: 57.0 59.0 65.0 58.0 58.0 56.0 56.0 109.0 54.0 57.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 21:17:47 INFO - PROCESS | 31966 | Values: 58.0 59.0 59.0 58.0 59.0 58.0 59.0 59.0 59.0 59.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:2.83 (3.5%) stddev-sans-first:2.96 21:17:47 INFO - PROCESS | 31966 | Values: 80.0 79.0 79.0 80.0 80.0 85.0 80.0 79.0 86.0 85.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:126.50 stddev:20.27 (16.0%) stddev-sans-first:21.42 21:17:47 INFO - PROCESS | 31966 | Values: 127.0 125.0 124.0 126.0 122.0 130.0 121.0 131.0 189.0 125.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:169.50 stddev:2.36 (1.4%) stddev-sans-first:2.46 21:17:47 INFO - PROCESS | 31966 | Values: 167.0 171.0 166.0 166.0 166.0 170.0 169.0 172.0 170.0 166.0 21:17:47 INFO - PROCESS | 31966 | 21:17:47 INFO - PROCESS | 31966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:67.50 stddev:2.31 (3.4%) stddev-sans-first:2.33 21:17:47 INFO - PROCESS | 31966 | Values: 68.0 64.0 68.0 64.0 65.0 68.0 69.0 65.0 62.0 67.0 21:17:47 INFO - PROCESS | 31966 | -------- Summary: end -------- 21:17:47 INFO - PROCESS | 31966 | 21:17:48 INFO - TEST-INFO | 31966: exit 0 21:17:48 INFO - TEST-OK | kraken | took 62425ms 21:17:48 INFO - SUITE-END | took 1175s 21:17:48 INFO - Completed test suite (00:19:35) 21:17:48 INFO - javascript benchmark 21:17:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.9685003149975, 3157.131788758092, 3182.4908014717644, 3184.3949649566594, 3216.2602601401677, 5263.789448422063, 5358.6516876403, 5362.0616392131415, 5367.731613419333, 5418.0, 5364.061289274371, 5369.62412631116, 5422.0, 5441.755121019553, 5442.102053161234, 4848.17581011229, 4861.975690121553, 5036.521530454601, 5073.061483625541, 5091.159958606825, 4851.951480485185, 5001.024800163969, 5006.74966251686, 5044.672096313746, 5086.542211200991, 4841.903161936759, 4861.562459378655, 4880.731559764212, 4916.655834091615, 4918.311436398907, 4893.09477746618, 4909.852704418873, 4915.361003069578, 4917.852464426073, 4925.679830810986, 4812.230043193107, 4863.076015557032, 4877.780499877514, 4879.2925025871045, 4931.506849315076, 5355.6786592804165, 5359.464053594648, 5389.461053894618, 5390.245365648812, 5391.056565101092, 5824.068149096167, 5846.912296315516, 5861.3552509223955, 5868.354481007086, 5877.9412205877825, 5896.439838215363, 5973.163757074013, 5987.341392446828, 5990.2212712347555, 5995.460408563206, 5516.117421212587, 5541.750621222055, 5544.112941929272, 5594.58040646949, 5601.663900165962, 5841.707914604338, 5980.312264089598, 6049.243844519435, 6056.515478761777, 6073.180120683651, 5833.533317334603, 5845.532357411397, 5907.911381329283, 5913.615614985012, 5914.0241860093465, 5932.080527518242, 5932.080527518242, 5936.9406305937255, 5965.880682386328, 5986.012307969223, 5631.465010823965, 5767.0, 5793.073108302736, 5808.332041815161, 5850.912236316459, 5859.736311865976, 5860.355360910296, 5863.091220860773, 5868.735906884201, 5871.295444546682, 4325.351197320427, 4443.466783985942, 4443.600075993176, 4445.333200020023, 4492.191405547033, 3909.6285852844503, 3924.803759811998, 3940.2907476654477, 3947.782871942013, 3985.322495175827, 5513.669179849222, 5551.472610102034, 5556.222128901957, 5561.6663000220115, 5563.415841336682, 5704.258446401941, 5818.738156782871, 5911.497522710618, 5917.46742793142, 5919.0, 5499.230107784913, 5521.944780552143, 5543.0, 5544.584156188302, 5596.692181929951, 5038.067957427887, 5050.292958985745, 5053.31780209667, 5056.544910958031, 5101.132807422747, 5941.762329506858, 5975.25309336333, 6039.245094363205, 6073.18012068374, 6084.756609735561, 5897.351291358033, 5901.409859014236, 5910.320313163869, 5913.497352725067, 5916.0, 6006.219191505076, 6038.064100064497, 6050.0, 6050.6369617823075, 6059.21230240066, 5628.690422026828, 5676.801311954062, 5756.366799652119, 5791.131330300489, 5808.883822323445, 5894.233749612523, 5900.409959004065, 5908.3205431375945, 5913.674747888907, 5928.110783382527, 5741.8564535886935, 5754.856128596819, 5756.079027355603, 5756.251687280626, 5756.453136951983, 5546.140348246028, 5606.523445507014, 5624.0, 5635.605507614428, 5677.261955945701, 5508.44915508446, 5526.640768350045, 5541.6120871540215, 5558.499735023867, 5562.332520097614, 5515.338159420895, 5700.515456186271, 5711.0, 5757.8560535986935, 5765.336986246635, 5508.55931525485, 5564.805231816867, 5624.6625202487985, 5644.153376993484, 5665.03694371966], "value": 5381.11657158664, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6051884718393, 625.893598088325, 626.3454689849106, 636.5703150373497, 638.2245571630468, 29966.55050174249, 43027.78486107569, 44072.55927440725, 44083.338749918694, 44092.55907440925, 43302.13395732083, 43482.34776478355, 43515.564844351626, 43524.78237608815, 43632.34551481722, 7915.920840791605, 8777.2100510954, 8908.910910890905, 8909.821803563926, 10299.897001030005, 10041.0, 10452.529636166391, 10460.058594726474, 10463.790724185512, 10468.842967355497, 10443.060124588785, 10472.895271047306, 10488.213383996193, 10505.21210909181, 10511.106555942753, 8107.554084525378, 10413.0, 10451.895481045169, 10687.198460115522, 10692.732681682943, 10586.894131058667, 10618.840717389245, 10619.20355973305, 10651.946740266327, 10668.199885008578, 39724.0, 40009.79995100035, 40097.79951100255, 40126.59873401258, 40142.397864032064, 3475.322312149132, 3595.0473124621994, 3596.1908570571672, 3602.0814692253307, 3631.5642122945414, 31471.213219669462, 31562.684373156204, 31820.840895795372, 32643.347133057207, 32715.0, 4363.869083927487, 4408.977955110204, 4417.955820441786, 4433.024734558392, 4444.35556844259, 313660.0, 315936.0, 316523.0, 316589.0, 318795.0, 58429.707851461324, 58671.41328586745, 58913.41086589165, 59288.84978051495, 59346.70326648339, 61950.76098478005, 62288.37711622917, 62478.37521624816, 62715.0, 62799.778025526735, 17119.315227391013, 17760.111994400228, 17800.109994500224, 17809.287628494974, 17813.910930445265, 11953.163278570417, 13369.398377073056, 13557.457701691821, 13615.046946713834, 13898.166110033228, 17083.91458042702, 17518.562035949202, 17569.0, 17597.38409155699, 17666.0, 6148.1392605035335, 6169.383061693795, 6186.536009799283, 6187.0, 6397.328280530571, 1070.5075665193942, 1109.1348747976592, 1128.1707944660668, 1182.6865880541664, 1248.2260998181187, 31182.0, 32034.19914502156, 32104.83947580247, 32221.677783222338, 32395.190120246712, 1156.8380426740264, 1162.91859569831, 1200.7058270723553, 1213.3326670331282, 1264.3994102801096, 16783.664326713642, 16987.575310617085, 17274.0, 17283.0, 17294.913525432294, 450130.0, 454825.0, 454911.0, 456371.0, 456419.0, 56444.0, 57023.14465283024, 57285.0, 57362.42637573654, 57439.71280143572, 1311.0691409099645, 1404.39610967283, 1442.7330943775435, 1456.9781453278422, 1467.4612919649066, 30994.535081973336, 32924.67075329216, 32929.835350823094, 33347.166320842174, 33428.66571334353, 50530.2420463686, 51175.0, 51233.48766512436, 51423.48576514336, 51429.48570514247, 329842.0, 334909.2072634232, 335143.0, 335620.0, 336279.0, 35692.82153589215, 44132.55867441413, 44861.0, 45519.54480455153, 49613.0, 44031.0, 44806.77596611996, 45045.54954450545, 49412.50587494223, 49492.75253623709, 40924.79537602293, 42257.366139508544, 42656.78671606622, 43427.131457370044, 44153.55846441623, 41350.0, 42182.78908605437, 42273.0, 42870.78564607157, 43257.0, 42140.78929605332, 42709.14581708286, 43171.78414107909, 43368.132637347706, 43369.0, 35359.292814144086, 36803.631963681095, 37051.0, 37220.25559488849, 37613.43579846359, 28209.858950705115, 28721.425571488035, 28887.5666864993, 28903.42193156083, 29078.854605726836], "value": 20550.997422890312, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.7575317748695, 386.62883631713555, 393.8030984507744, 399.26077460543354, 400.3134624119634, 14302.642433939156, 17275.481735547954, 18182.272709091638, 19977.200911963522, 20025.499362515926, 14951.0, 17643.73534396985, 18584.070796460157, 18631.627367452642, 19477.610447791034, 5617.466340697637, 5778.27771528559, 5793.942060579404, 5801.82594522165, 5807.9419205808035, 4131.772752498611, 5714.942850571482, 5763.221965034709, 6005.3394126646035, 6311.431971122598, 6349.746010159588, 6352.9364706353035, 6353.968230158843, 6368.29948705642, 6376.394242546974, 6135.141080248769, 6331.683415829213, 6332.05019247112, 6339.778107766252, 6362.0, 5451.236826844245, 5505.862353441156, 5535.750891209906, 5569.192467092249, 5585.776568937237, 22098.779012209994, 22928.770712292997, 23029.309120726404, 23045.654315185286, 23142.884285578464, 2335.2877372401413, 2407.626817843237, 2451.8651474168914, 2596.260065881215, 2602.9349266268305, 14319.284035798273, 14344.211068391234, 14360.56918292453, 14454.855451445455, 14570.271486425743, 1945.620603982224, 1951.3560525026708, 1952.7461430014007, 2064.917403303866, 2109.7257356543705, 79315.60342198309, 85547.57226213891, 86135.0, 86658.0, 88242.55878720565, 10013.349132306377, 10038.297319187734, 10415.843762343571, 10441.0, 10570.207234457446, 14049.157050576998, 14106.506272280421, 14146.787798183035, 14149.151050936976, 14180.787288190686, 8204.179582041748, 8572.657093716307, 8621.224089831945, 8719.60761765722, 8734.0, 7237.023001894782, 8575.699850505202, 8665.0, 8768.868466973001, 8799.868001979976, 5919.55603329752, 6291.496680265568, 6482.319356467598, 6513.348665133543, 6533.314002029813, 1855.3228071753983, 1891.304890530988, 1897.4023182697406, 1959.5884864178681, 1969.0351727653347, 970.7573106723319, 1077.1490522487304, 1137.3176094343328, 1144.3248483394837, 1162.1574358589955, 18359.17383717736, 18653.626927461646, 19181.520461988282, 19212.327568535315, 19538.413847584594, 1012.7215015870695, 1023.3757407981126, 1023.9795204095876, 1089.4334945828125, 1098.1653943003216, 9917.950410247902, 10444.112250458644, 10480.109190718722, 10498.895011049792, 10503.579856805794, 214150.0, 459485.0, 471006.0, 471085.0, 472026.0, 94431.52784236034, 94882.52558737162, 95923.52038239765, 97257.0, 97347.0, 1073.849661047454, 1088.9401082940356, 1102.2890235797865, 1110.1063643766845, 1120.966371008871, 16062.598435039217, 16258.67482650364, 16290.51128466148, 16430.917845410695, 16485.58786030359, 38291.61708382992, 38557.0, 38720.80639596784, 38763.41854872236, 39143.30280366374, 52435.0, 55113.72443137919, 56037.71981140068, 56469.43530564642, 56939.430605693415, 8134.105248422788, 8386.203310685476, 8684.869726954226, 11689.590864319707, 12457.0, 8302.70940517079, 12309.322987235788, 13460.798088028883, 13819.930900345435, 13966.860331396556, 12662.176958497668, 12736.172148810298, 12878.742425151631, 12895.226286422845, 12980.545680901123, 12097.879021209676, 12290.262584244974, 12402.441890114786, 12596.496140154291, 12767.042471814837, 12877.227366358049, 13040.54358097462, 13076.542321018718, 13187.274699891597, 13268.0, 13070.085094043327, 13076.673083172996, 13086.411111500196, 13180.143290686075, 13181.275029873066, 12836.486540538273, 12978.351082445652, 13001.674958126123, 13015.284159371326, 13134.60596182116], "value": 9614.493216998497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.233965469855, 1480.7630779075346, 1521.650020495286, 1656.6769479951415, 1804.179098510178, 8410.369222308329, 8722.825543489127, 8756.211940925323, 8993.055729148427, 9009.459432434041, 8593.355498337634, 8818.07410221927, 8876.334274929373, 8895.421797583153, 8906.599203035863, 2323.9302820915314, 2341.1922886604093, 2342.8360014798973, 2346.507233480971, 2349.2717257650097, 2302.4359032037173, 2319.5708793873187, 2360.9173678921156, 2367.7040369953756, 2370.111208296889, 2260.9434764130947, 2294.5640328337563, 2306.7577904320055, 2339.2046704120594, 2340.8127349812057, 2216.9778302216932, 2234.910603575855, 2251.819854411643, 2252.256755270765, 2253.1663284584642, 2200.19692812124, 2203.162798136698, 2205.6250437425674, 2206.0403724379785, 2208.182972300243, 8712.172343627346, 8824.823503529959, 8898.288136949028, 8902.065283145306, 8984.820303593891, 5278.366596008465, 5367.141257398836, 5388.676679399209, 5396.244525766396, 5415.539679127279, 3424.743144264165, 3448.0862571418593, 3511.929761404783, 3539.823008849573, 3557.0, 1063.500154927183, 1100.4002818463875, 1118.5973049702181, 1145.8052131137642, 1146.40386998761, 12283.201591896499, 12426.937865310616, 12434.62696119118, 12446.81329780054, 12450.937745311216, 4547.454305483297, 4591.471980722193, 4682.765861706901, 4697.037107392976, 4703.223968045303, 9976.102150806317, 9984.600615975425, 9987.700368988943, 9995.0, 10001.949990250003, 5187.714675692873, 5187.870303242374, 5196.558292545101, 5209.322788037607, 5224.190250511177, 4313.9137217255475, 4689.1559519286175, 4803.78382972767, 4908.803647854117, 4913.680610760289, 3949.822257998397, 4014.237294913957, 4084.9795751021056, 4100.630943215125, 4166.458360413127, 1286.067600989294, 1306.4839388441703, 1313.4680454415977, 1318.1168617026615, 1332.0409305300168, 804.9557274349967, 886.423824514071, 969.6266937229077, 987.7674166197808, 993.0, 5712.80005199816, 5720.399358067426, 5974.880502389928, 5994.0409534474275, 6058.515318774487, 948.0661548374845, 984.2175470500969, 1009.3035805294323, 1019.97450063749, 1046.3355769086684, 3835.4055121456217, 3924.9018774530864, 3950.7036972227197, 3967.0677390813134, 4008.378701301303, 10656.254062215725, 11116.61091861781, 11194.720131996764, 11265.605703800327, 11297.548098075986, 10975.0, 11088.5564577416, 11140.944295278472, 11145.888541114648, 11147.832782508107, 7857.449978501564, 8247.298979586802, 8321.16788321163, 8354.164583541597, 8362.623681934327, 6014.248218972629, 6029.728662210124, 6112.969435152796, 6118.510519158368, 6179.907301390393, 10184.694459166238, 10221.284510084222, 10357.482125893826, 10377.117944974761, 10458.163346932379, 10430.843537347098, 10530.842037369292, 10535.63125290611, 10638.468076596295, 10662.84005739899, 7883.605819709106, 7950.204979502004, 7982.481138726196, 7986.680532778856, 7991.160928102466, 8514.106018868177, 8587.87118193215, 8658.870116948377, 8671.566421679017, 8745.125487451458, 7921.722739704082, 7953.085395179628, 7982.84034319322, 8023.157568455228, 8052.83894322122, 7759.92240077592, 7783.455158139102, 7881.330086942674, 7882.132965373689, 7928.127905930228, 7135.5361901476235, 7136.215016348301, 7204.639768011683, 7212.062431883822, 7222.09723784527, 4960.528749768766, 5101.821436249714, 5115.309433226466, 5175.353080864892, 5194.428612852659, 4860.878478038077, 4920.581750551243, 5001.4998500149695, 5074.5686616637995, 5225.51072944209], "value": 4667.3510170067675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8784012757899, 342.4948201402931, 345.3472936150675, 347.42327735958315, 348.7558708903766, 5273.920891186631, 5275.657082289648, 5298.4436634153435, 5300.522952934235, 5336.998625515432, 5234.895302093965, 5250.0, 5251.973740131303, 5266.841994740154, 5309.867253318659, 3931.5478719947287, 3997.860074897379, 4117.3618089196225, 4124.9587504124875, 4132.318167502359, 4069.7354671946377, 4073.226087043467, 4090.365993271048, 4103.138340948404, 4115.135821477494, 3889.844406223762, 4069.877903662895, 4071.531773846016, 4078.7348822326453, 4089.548210385315, 3958.4656071430422, 4036.6568841648495, 4089.345704687236, 4123.154753275571, 4136.73111247768, 3619.927601447983, 3660.7437479376454, 3664.175560498893, 3674.3386190485703, 3698.8335524901445, 5021.297018417425, 5022.824201152978, 5035.269885866565, 5035.597152227813, 5035.748212589356, 4507.271877764853, 4751.239801631757, 4777.0, 4777.641676874248, 4782.402199725035, 5446.2647542582035, 5455.5908306877145, 5478.616496845222, 5507.339119305669, 5509.972450137764, 4044.4944381952255, 4087.5299340575916, 4093.692973027035, 4098.262312783698, 4106.609872062149, 5616.971915140398, 5642.181883626851, 5679.460451257124, 5688.317401911797, 5746.626469279525, 4024.269564087412, 4076.470058892325, 4087.9386809197886, 4088.6729061674996, 4114.238865809834, 4144.611555129066, 4167.958320416757, 4171.249175148441, 4179.226843034048, 4179.6029377209115, 4441.0, 4664.370310008106, 4691.366665500182, 4724.551167639069, 4734.857954261378, 5477.945220547823, 5495.505404513533, 5496.230527726121, 5504.146857237135, 5551.834114835849, 1407.3596513586294, 1412.265621876639, 1414.8514405987223, 1418.638247246966, 1422.2248874363497, 910.4173329069268, 916.1617120334952, 929.3912487320681, 934.275936149476, 956.5647630328184, 5316.73416329182, 5326.97336513315, 5338.8665283367445, 5341.759620817073, 5347.465253474621, 5530.474604912527, 5532.7786888524815, 5539.390667026624, 5556.166575013699, 5590.440955904458, 5026.246063090565, 5247.035424984948, 5266.2890509781455, 5280.287161233261, 5361.597880159004, 2986.7909246352983, 3022.6826183250882, 3024.3346463777934, 3045.8477076146105, 3047.5885755422732, 5783.768649253982, 5838.678872662044, 5850.0, 5874.765009399576, 5890.793822216202, 5529.391766905637, 5813.709314534256, 5815.575184079928, 5817.941820581825, 5826.417358264224, 5840.240768700041, 5844.590878638454, 5861.007257532459, 5868.677222752704, 5874.706264686834, 5427.213054107211, 5672.602917795714, 5694.373618902, 5696.572757043155, 5757.0, 5612.130119831432, 5613.214150019082, 5636.802711905064, 5639.492445679908, 5653.0, 5839.802840417619, 5879.735411906389, 5958.493528049991, 5962.25471816023, 5996.070609055603, 3904.4533765272317, 4047.9797601011805, 4053.8986525337104, 4063.1264278180333, 4077.266092103331, 5648.830535083954, 5744.856378590569, 5770.711464426846, 5788.479036886701, 5810.331811841692, 5331.973340133274, 5393.8921221574565, 5531.419200983839, 5557.666540007613, 5602.691851948182, 5489.917651235314, 5493.945060549343, 5530.446955304437, 5541.722913854211, 5557.249771280987, 5229.895402092013, 5418.701971391612, 5460.7542660579575, 5480.150576660624, 5490.149026900836, 5546.972265138648, 5560.666360018412, 5579.911917176111, 5582.162675598693, 5595.216669666169, 5374.570034397317, 5425.918611220756, 5456.809011684572, 5495.560355171657, 5498.3127109111365], "value": 4223.900790968928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.9388848892089, 800.5676934455395, 839.1524560194202, 844.8056946902212, 856.3235044314991, 14444.783328250085, 15072.623184420396, 15101.471448499306, 15109.546713598582, 15155.772663410058, 13134.21194728317, 13247.933760331209, 13257.668558286023, 13272.20366777994, 13280.535181268633, 668.862883108964, 799.3964556759638, 812.6140083460339, 829.5022986208257, 829.8589239829244, 829.7593697827623, 830.2735106781566, 833.0586437325813, 833.5457175839152, 838.5765188579759, 882.1927935938609, 884.3455842676406, 884.6682494064726, 884.7743825324566, 885.3802338363139, 726.4733068525329, 854.8674955381895, 866.0906048648957, 873.9344549158839, 876.1413814461863, 645.5997281685385, 646.6217262901208, 647.1166857239881, 647.3429469088878, 647.3558808985043, 12851.935740321333, 12855.74288514234, 12862.970962322992, 12864.421101050475, 12930.224186548838, 12585.181963172365, 12598.055145864097, 13022.869771302356, 13554.0, 13823.654408639864, 10103.393796372242, 10104.646337378157, 10283.897161028368, 12077.57728479499, 12511.311877846714, 4485.686001979862, 4532.184206842767, 4580.770961451914, 4609.367585576508, 4660.091282199973, 52959.73520132413, 53261.467385326425, 53807.73096134494, 54197.0, 54387.456125438635, 10983.231173817756, 11070.612528561624, 11181.496832642551, 11230.775384492428, 11309.773804523864, 18491.352802651843, 18502.44492665195, 18514.0, 18799.0, 18827.905860470884, 7876.0, 8007.319377852831, 8114.107448180695, 8223.629936652746, 8334.70828521011, 4540.931886021713, 4586.587207151372, 4678.7660616969015, 4734.124187025412, 4934.259861020804, 3311.089450401159, 3425.7773244739014, 3426.417509023472, 3426.674465925733, 3429.8456569454434, 652.9902051469231, 660.6531570925303, 663.6515829189617, 672.4586707700348, 672.9966350168218, 701.7859552836331, 707.2361849202952, 730.4667592657283, 741.0625558668289, 756.3608750605729, 8736.257418119403, 8771.517566533774, 8775.868361974575, 8810.383273170817, 9112.316576256808, 580.5181699189662, 711.345562082885, 735.3675838778646, 765.9195784442553, 772.6754762999553, 4387.736735795863, 4420.292753159543, 4468.191817418879, 4609.723416594948, 4740.525947405232, 67841.66079169573, 68551.65724171347, 71345.28654713386, 71471.2852871475, 71801.0, 59871.40128598746, 61129.38870611326, 61469.38530614726, 62163.37836621666, 62724.372756271856, 55142.17286740622, 55862.72068639631, 56191.71904140453, 56681.7165914176, 56909.14636280542, 8668.696595619123, 8772.868406973774, 8896.911030889609, 8993.838607405469, 9059.637614495346, 33329.83335083406, 33419.16452088717, 33547.496787547716, 34224.0, 35138.0, 43404.78297608492, 44104.558954410044, 44272.778636107905, 44569.55430445784, 44682.41469816273, 11654.650360489199, 11768.35274059935, 11917.94041029824, 12810.359482026048, 12954.639762824767, 13827.585172444842, 14102.123291425758, 14262.786058209344, 14332.211728355041, 14547.709045819236, 13233.602991910258, 13416.39626216842, 13579.388927498483, 13997.790033149307, 14196.574102776933, 13175.341232938506, 13471.0, 13802.585922422344, 13863.79204311916, 14123.081999669988, 12506.874931250572, 12673.429695663533, 12773.23360598367, 12908.870911290767, 13220.867791321964, 11036.337819730841, 11102.777944441228, 11242.437878105899, 11340.432978350884, 11569.768604627692, 11078.390688512209, 11268.323900565993, 11365.008708149757, 11461.942690286494, 11558.190926635054], "value": 6891.55128868542, "unit": "score"}], "name": "dromaeo_css", "value": 7243.745291999264, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 110.0, 110.0, 112.0, 109.0, 110.0, 109.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 161.0, 203.0, 133.0, 150.0, 151.0, 125.0, 198.0, 123.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 146.0, 76.0, 76.0, 76.0, 76.0, 142.0, 76.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 155.0, 93.0, 91.0, 91.0, 126.0, 91.0, 91.0, 122.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 144.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 65.0, 58.0, 58.0, 56.0, 56.0, 109.0, 54.0, 57.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 80.0, 85.0, 80.0, 79.0, 86.0, 85.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 124.0, 126.0, 122.0, 130.0, 121.0, 131.0, 189.0, 125.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 166.0, 166.0, 166.0, 170.0, 169.0, 172.0, 170.0, 166.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 68.0, 64.0, 65.0, 68.0, 69.0, 65.0, 62.0, 67.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1542.5, "alertThreshold": 2.0}]} 21:17:48 INFO - Return code: 0 21:17:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:17:48 ERROR - # TBPL SUCCESS # 21:17:48 INFO - Running post-action listener: _resource_record_post_action 21:17:48 INFO - ##### 21:17:48 INFO - ##### Finished run-tests step (success) 21:17:48 INFO - ##### 21:17:48 INFO - Running post-run listener: _resource_record_post_run 21:17:49 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 544681984; Read time: 188; Write time: 383084 21:17:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253906944; Read time: 0; Write time: 207308 21:17:49 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290775040; Read time: 188; Write time: 175776 21:17:49 INFO - Running post-run listener: _upload_blobber_files 21:17:49 INFO - Blob upload gear active. 21:17:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:17:49 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 21:17:49 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:17:49 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:17:50 INFO - (blobuploader) - INFO - Open directory for files ... 21:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:51 INFO - (blobuploader) - INFO - Done attempting. 21:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:51 INFO - (blobuploader) - INFO - Done attempting. 21:17:51 INFO - (blobuploader) - INFO - Iteration through files over. 21:17:51 INFO - Return code: 0 21:17:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:17:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:17:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e57ee0e113cc640022cf8aa0845bdb9e68c06cfa427f0bf813df46135852528bfe289b518fad9a5c48f8901396b6119f92112ed9af40e76b737e84aad4edd5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5da89f3a1e634ccc0a77da8c003c6e2f70ddb6307461cdf7aeb7311bdd6768b2e63ffe1246bfd4109240a6996f56ad1856a56d56b80bbfbe2dc0139d573f28ad"} 21:17:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:17:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:17:51 INFO - Contents: 21:17:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e57ee0e113cc640022cf8aa0845bdb9e68c06cfa427f0bf813df46135852528bfe289b518fad9a5c48f8901396b6119f92112ed9af40e76b737e84aad4edd5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5da89f3a1e634ccc0a77da8c003c6e2f70ddb6307461cdf7aeb7311bdd6768b2e63ffe1246bfd4109240a6996f56ad1856a56d56b80bbfbe2dc0139d573f28ad"} 21:17:51 INFO - Running post-run listener: copy_logs_to_upload_dir 21:17:51 INFO - Copying logs to upload dir... 21:17:51 INFO - mkdir: /builds/slave/test/build/upload/logs 21:17:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.188372 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-20 21:17:51.681940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 21:17:51.685976) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e57ee0e113cc640022cf8aa0845bdb9e68c06cfa427f0bf813df46135852528bfe289b518fad9a5c48f8901396b6119f92112ed9af40e76b737e84aad4edd5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5da89f3a1e634ccc0a77da8c003c6e2f70ddb6307461cdf7aeb7311bdd6768b2e63ffe1246bfd4109240a6996f56ad1856a56d56b80bbfbe2dc0139d573f28ad"} build_url:https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/fB_MBqm7TSqqCka5crdXXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e57ee0e113cc640022cf8aa0845bdb9e68c06cfa427f0bf813df46135852528bfe289b518fad9a5c48f8901396b6119f92112ed9af40e76b737e84aad4edd5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5da89f3a1e634ccc0a77da8c003c6e2f70ddb6307461cdf7aeb7311bdd6768b2e63ffe1246bfd4109240a6996f56ad1856a56d56b80bbfbe2dc0139d573f28ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 21:17:51.711011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 21:17:51.711334) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463802276.71979-1213417410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 21:17:51.794432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 21:17:51.794785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 21:17:51.795084) ========= ========= Total master_lag: 0.18 =========