builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1461042616.83 results: success (0) buildid: 20160418205131 builduid: d5db07eff05d47449dc0edb10d63b704 revision: cb65ec85049efa44b18e2e8d06af26768c3bfb94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:16.828430) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:16.829000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:16.829370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:16.846023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:16.846388) ========= 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=df17445c3590ff7897617a0e00000225-1461040802.438243-614595192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 22:10: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% 222M=0s 2016-04-18 22:10:17 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:16.958140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:16.958480) ========= 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=df17445c3590ff7897617a0e00000225-1461040802.438243-614595192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:17.010628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:17.011221) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb65ec85049efa44b18e2e8d06af26768c3bfb94 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb65ec85049efa44b18e2e8d06af26768c3bfb94 --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=df17445c3590ff7897617a0e00000225-1461040802.438243-614595192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 22:10:17,257 truncating revision to first 12 chars 2016-04-18 22:10:17,257 Setting DEBUG logging. 2016-04-18 22:10:17,257 attempt 1/10 2016-04-18 22:10:17,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb65ec85049e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 22:10:17,538 unpacking tar archive at: mozilla-central-cb65ec85049e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574527 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:17.709450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:17.709790) ========= script_repo_revision: cb65ec85049efa44b18e2e8d06af26768c3bfb94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:17.710207) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:17.710495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 22:10:17.720759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-18 22:10:17.721042) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=df17445c3590ff7897617a0e00000225-1461040802.438243-614595192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:10:18 INFO - MultiFileLogger online at 20160418 22:10:18 in /builds/slave/test 22:10:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:10:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:10:18 INFO - {'append_to_log': False, 22:10:18 INFO - 'base_work_dir': '/builds/slave/test', 22:10:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:10:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:10:18 INFO - 'branch': 'Firefox-Non-PGO', 22:10:18 INFO - 'buildbot_json_path': 'buildprops.json', 22:10:18 INFO - 'config_files': ('talos/linux_config.py',), 22:10:18 INFO - 'default_actions': ('clobber', 22:10:18 INFO - 'read-buildbot-config', 22:10:18 INFO - 'download-and-extract', 22:10:18 INFO - 'populate-webroot', 22:10:18 INFO - 'create-virtualenv', 22:10:18 INFO - 'install', 22:10:18 INFO - 'run-tests'), 22:10:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:10:18 INFO - 'download_minidump_stackwalk': True, 22:10:18 INFO - 'download_symbols': 'ondemand', 22:10:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:10:18 INFO - 'tooltool.py': '/tools/tooltool.py', 22:10:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:10:18 INFO - '/tools/misc-python/virtualenv.py')}, 22:10:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:10:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:10:18 INFO - 'installer_path': 'installer.exe', 22:10:18 INFO - 'log_level': 'info', 22:10:18 INFO - 'log_name': 'talos', 22:10:18 INFO - 'log_to_console': True, 22:10:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:10:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:10:18 INFO - 'opt_config_files': (), 22:10:18 INFO - 'pip_index': False, 22:10:18 INFO - 'sps_profile': False, 22:10:18 INFO - 'sps_profile_interval': 0, 22:10:18 INFO - 'suite': 'dromaeojs-e10s', 22:10:18 INFO - 'system_bits': '32', 22:10:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:10:18 INFO - 'title': 'talos-linux64-ix-021', 22:10:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:10:18 INFO - 'use_talos_json': True, 22:10:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:10:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:10:18 INFO - 'work_dir': 'build'} 22:10:18 INFO - ##### 22:10:18 INFO - ##### Running clobber step. 22:10:18 INFO - ##### 22:10:18 INFO - Running pre-action listener: _resource_record_pre_action 22:10:18 INFO - Running main action method: clobber 22:10:18 INFO - rmtree: /builds/slave/test/build 22:10:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:10:19 INFO - Running post-action listener: _resource_record_post_action 22:10:19 INFO - ##### 22:10:19 INFO - ##### Running read-buildbot-config step. 22:10:19 INFO - ##### 22:10:19 INFO - Running pre-action listener: _resource_record_pre_action 22:10:19 INFO - Running main action method: read_buildbot_config 22:10:19 INFO - Using buildbot properties: 22:10:19 INFO - { 22:10:19 INFO - "project": "", 22:10:19 INFO - "product": "firefox", 22:10:19 INFO - "script_repo_revision": "production", 22:10:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:10:19 INFO - "repository": "", 22:10:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:10:19 INFO - "buildid": "20160418205131", 22:10:19 INFO - "pgo_build": "False", 22:10:19 INFO - "basedir": "/builds/slave/test", 22:10:19 INFO - "buildnumber": 294, 22:10:19 INFO - "slavename": "talos-linux64-ix-021", 22:10:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:10:19 INFO - "platform": "ubuntu64_hw", 22:10:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:10:19 INFO - "branch": "mozilla-central", 22:10:19 INFO - "repo_path": "mozilla-central", 22:10:19 INFO - "revision": "cb65ec85049efa44b18e2e8d06af26768c3bfb94", 22:10:19 INFO - "stage_platform": "linux64", 22:10:19 INFO - "builduid": "d5db07eff05d47449dc0edb10d63b704", 22:10:19 INFO - "slavebuilddir": "test" 22:10:19 INFO - } 22:10:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:10:19 INFO - Running post-action listener: _resource_record_post_action 22:10:19 INFO - ##### 22:10:19 INFO - ##### Running download-and-extract step. 22:10:19 INFO - ##### 22:10:19 INFO - Running pre-action listener: _resource_record_pre_action 22:10:19 INFO - Running main action method: download_and_extract 22:10:19 INFO - mkdir: /builds/slave/test/build/tests 22:10: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')]} 22:10:19 INFO - https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:10:21 INFO - Downloaded 1361 bytes. 22:10:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:10:21 INFO - Using the following test package requirements: 22:10:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:10:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:10:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:10:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'jsshell-linux-x86_64.zip'], 22:10:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:10:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:10:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:10:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:10:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:10:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:10:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:10:21 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')]} 22:10:21 INFO - https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:10:25 INFO - Downloaded 22209354 bytes. 22:10:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:10:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:10:27 INFO - Return code: 0 22:10:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:10: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')]} 22:10:27 INFO - https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:10:33 INFO - Downloaded 22209354 bytes. 22:10:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:10:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:10:34 INFO - Return code: 0 22:10:34 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')]} 22:10:34 INFO - https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:10:36 INFO - Downloaded 10845952 bytes. 22:10:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:10:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:10:36 INFO - Return code: 0 22:10: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')]} 22:10:36 INFO - https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:10:38 INFO - Downloaded 54451310 bytes. 22:10:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:10:38 INFO - mkdir: /builds/slave/test/properties 22:10:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:10:38 INFO - Writing to file /builds/slave/test/properties/build_url 22:10:38 INFO - Contents: 22:10:38 INFO - build_url:https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:10:38 INFO - Running post-action listener: _resource_record_post_action 22:10:38 INFO - Running post-action listener: set_extra_try_arguments 22:10:38 INFO - ##### 22:10:38 INFO - ##### Running populate-webroot step. 22:10:38 INFO - ##### 22:10:38 INFO - Running pre-action listener: _resource_record_pre_action 22:10:38 INFO - Running main action method: populate_webroot 22:10:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:10:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:10:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:10:38 INFO - '--tppagecycles', 22:10:38 INFO - '7'], 22:10:38 INFO - 'tests': ['tsvgm']}}, 22:10:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:10:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:10:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:10:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:10:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['damp', 'tps']}, 22:10:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'tests': ['damp', 'tps']}, 22:10:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['dromaeo_dom']}, 22:10:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:10:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['a11yr', 22:10:38 INFO - 'ts_paint', 22:10:38 INFO - 'tpaint', 22:10:38 INFO - 'sessionrestore', 22:10:38 INFO - 'sessionrestore_no_auto_restore', 22:10:38 INFO - 'tabpaint']}, 22:10:38 INFO - 'other-e10s': {'tests': ['a11yr', 22:10:38 INFO - 'ts_paint', 22:10:38 INFO - 'tpaint', 22:10:38 INFO - 'sessionrestore', 22:10:38 INFO - 'sessionrestore_no_auto_restore', 22:10:38 INFO - 'tabpaint']}, 22:10:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:10:38 INFO - 'ts_paint', 22:10:38 INFO - 'tpaint', 22:10:38 INFO - 'sessionrestore', 22:10:38 INFO - 'sessionrestore_no_auto_restore', 22:10:38 INFO - 'tabpaint']}, 22:10:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:10:38 INFO - 'ts_paint', 22:10:38 INFO - 'tpaint', 22:10:38 INFO - 'sessionrestore', 22:10:38 INFO - 'sessionrestore_no_auto_restore', 22:10:38 INFO - 'tabpaint']}, 22:10:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['a11yr', 22:10:38 INFO - 'ts_paint', 22:10:38 INFO - 'tpaint', 22:10:38 INFO - 'sessionrestore', 22:10:38 INFO - 'sessionrestore_no_auto_restore', 22:10:38 INFO - 'tabpaint']}, 22:10:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['a11yr', 22:10:38 INFO - 'ts_paint', 22:10:38 INFO - 'tpaint', 22:10:38 INFO - 'sessionrestore', 22:10:38 INFO - 'sessionrestore_no_auto_restore', 22:10:38 INFO - 'tabpaint']}, 22:10:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['tsvgx', 22:10:38 INFO - 'tsvgr_opacity', 22:10:38 INFO - 'tart', 22:10:38 INFO - 'tscrollx', 22:10:38 INFO - 'cart']}, 22:10:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:10:38 INFO - 'tsvgr_opacity', 22:10:38 INFO - 'tart', 22:10:38 INFO - 'tscrollx', 22:10:38 INFO - 'cart']}, 22:10:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'talos_options': ['--disable-e10s'], 22:10:38 INFO - 'tests': ['tp5o']}, 22:10:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'tests': ['tp5o']}, 22:10:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'talos_options': ['--disable-e10s', 22:10:38 INFO - '--xperf_path', 22:10:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:10:38 INFO - 'tests': ['tp5n']}, 22:10:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:38 INFO - 'talos_options': ['--xperf_path', 22:10:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:10:38 INFO - 'tests': ['tp5n']}}, 22:10:38 INFO - 'talos.zip': {'path': '', 22:10:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:10:38 INFO - Running post-action listener: _resource_record_post_action 22:10:38 INFO - ##### 22:10:38 INFO - ##### Running create-virtualenv step. 22:10:38 INFO - ##### 22:10:38 INFO - Running pre-action listener: _resource_record_pre_action 22:10:38 INFO - Running main action method: create_virtualenv 22:10:38 INFO - Creating virtualenv /builds/slave/test/build/venv 22:10:38 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 22:10:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:10:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:10:39 INFO - Using real prefix '/usr' 22:10:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:10:39 INFO - Installing distribute.............................................................................................................................................................................................done. 22:10:41 INFO - Installing pip.................done. 22:10:41 INFO - Return code: 0 22:10:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:10:41 INFO - Using env: {'DISPLAY': ':0', 22:10:41 INFO - 'HOME': '/home/cltbld', 22:10:41 INFO - 'LANG': 'en_US.UTF-8', 22:10:41 INFO - 'LANGUAGE': 'en_US:en', 22:10:41 INFO - 'LOGNAME': 'cltbld', 22:10:41 INFO - 'MAIL': '/var/mail/cltbld', 22:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:41 INFO - 'MOZ_NO_REMOTE': '1', 22:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:41 INFO - 'NO_EM_RESTART': '1', 22:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:41 INFO - 'PWD': '/builds/slave/test', 22:10:41 INFO - 'SHELL': '/bin/bash', 22:10:41 INFO - 'SHLVL': '1', 22:10:41 INFO - 'TERM': 'linux', 22:10:41 INFO - 'TMOUT': '86400', 22:10:41 INFO - 'USER': 'cltbld', 22:10:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:41 INFO - '_': '/tools/buildbot/bin/python'} 22:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:41 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 22:10:41 INFO - Cleaning up... 22:10:41 INFO - Return code: 0 22:10:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:10:41 INFO - Using env: {'DISPLAY': ':0', 22:10:41 INFO - 'HOME': '/home/cltbld', 22:10:41 INFO - 'LANG': 'en_US.UTF-8', 22:10:41 INFO - 'LANGUAGE': 'en_US:en', 22:10:41 INFO - 'LOGNAME': 'cltbld', 22:10:41 INFO - 'MAIL': '/var/mail/cltbld', 22:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:41 INFO - 'MOZ_NO_REMOTE': '1', 22:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:41 INFO - 'NO_EM_RESTART': '1', 22:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:41 INFO - 'PWD': '/builds/slave/test', 22:10:41 INFO - 'SHELL': '/bin/bash', 22:10:41 INFO - 'SHLVL': '1', 22:10:41 INFO - 'TERM': 'linux', 22:10:41 INFO - 'TMOUT': '86400', 22:10:41 INFO - 'USER': 'cltbld', 22:10:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:41 INFO - '_': '/tools/buildbot/bin/python'} 22:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:41 INFO - Downloading/unpacking psutil>=0.7.1 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:10:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:10:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:10:43 INFO - Installing collected packages: psutil 22:10:43 INFO - Running setup.py install for psutil 22:10:43 INFO - building 'psutil._psutil_linux' extension 22:10:43 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 22:10:44 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 22:10:44 INFO - building 'psutil._psutil_posix' extension 22:10:44 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 22:10:44 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 22:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:10:44 INFO - Successfully installed psutil 22:10:44 INFO - Cleaning up... 22:10:44 INFO - Return code: 0 22:10:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:10:44 INFO - Using env: {'DISPLAY': ':0', 22:10:44 INFO - 'HOME': '/home/cltbld', 22:10:44 INFO - 'LANG': 'en_US.UTF-8', 22:10:44 INFO - 'LANGUAGE': 'en_US:en', 22:10:44 INFO - 'LOGNAME': 'cltbld', 22:10:44 INFO - 'MAIL': '/var/mail/cltbld', 22:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:44 INFO - 'MOZ_NO_REMOTE': '1', 22:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:44 INFO - 'NO_EM_RESTART': '1', 22:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:44 INFO - 'PWD': '/builds/slave/test', 22:10:44 INFO - 'SHELL': '/bin/bash', 22:10:44 INFO - 'SHLVL': '1', 22:10:44 INFO - 'TERM': 'linux', 22:10:44 INFO - 'TMOUT': '86400', 22:10:44 INFO - 'USER': 'cltbld', 22:10:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:44 INFO - '_': '/tools/buildbot/bin/python'} 22:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:10:46 INFO - Installing collected packages: mozsystemmonitor 22:10:46 INFO - Running setup.py install for mozsystemmonitor 22:10:46 INFO - Successfully installed mozsystemmonitor 22:10:46 INFO - Cleaning up... 22:10:46 INFO - Return code: 0 22:10:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:46 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 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:46 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 22:10:46 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 22:10:46 INFO - Using env: {'DISPLAY': ':0', 22:10:46 INFO - 'HOME': '/home/cltbld', 22:10:46 INFO - 'LANG': 'en_US.UTF-8', 22:10:46 INFO - 'LANGUAGE': 'en_US:en', 22:10:46 INFO - 'LOGNAME': 'cltbld', 22:10:46 INFO - 'MAIL': '/var/mail/cltbld', 22:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:46 INFO - 'MOZ_NO_REMOTE': '1', 22:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:46 INFO - 'NO_EM_RESTART': '1', 22:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:46 INFO - 'PWD': '/builds/slave/test', 22:10:46 INFO - 'SHELL': '/bin/bash', 22:10:46 INFO - 'SHLVL': '1', 22:10:46 INFO - 'TERM': 'linux', 22:10:46 INFO - 'TMOUT': '86400', 22:10:46 INFO - 'USER': 'cltbld', 22:10:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:46 INFO - '_': '/tools/buildbot/bin/python'} 22:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:10:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:10:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10:49 INFO - Downloading docopt-0.6.1.tar.gz 22:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:10:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:10:49 INFO - Running setup.py install for blobuploader 22:10:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:10:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:10:49 INFO - Running setup.py install for requests 22:10:50 INFO - Running setup.py install for docopt 22:10:50 INFO - Successfully installed blobuploader requests docopt 22:10:50 INFO - Cleaning up... 22:10:50 INFO - Return code: 0 22:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:50 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 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:50 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 22:10:50 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 22:10:50 INFO - Using env: {'DISPLAY': ':0', 22:10:50 INFO - 'HOME': '/home/cltbld', 22:10:50 INFO - 'LANG': 'en_US.UTF-8', 22:10:50 INFO - 'LANGUAGE': 'en_US:en', 22:10:50 INFO - 'LOGNAME': 'cltbld', 22:10:50 INFO - 'MAIL': '/var/mail/cltbld', 22:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:50 INFO - 'MOZ_NO_REMOTE': '1', 22:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:50 INFO - 'NO_EM_RESTART': '1', 22:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:50 INFO - 'PWD': '/builds/slave/test', 22:10:50 INFO - 'SHELL': '/bin/bash', 22:10:50 INFO - 'SHLVL': '1', 22:10:50 INFO - 'TERM': 'linux', 22:10:50 INFO - 'TMOUT': '86400', 22:10:50 INFO - 'USER': 'cltbld', 22:10:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:50 INFO - '_': '/tools/buildbot/bin/python'} 22:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:10:50 INFO - Running setup.py (path:/tmp/pip-NRej5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:10:50 INFO - Running setup.py (path:/tmp/pip-S3EIxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:10:50 INFO - Running setup.py (path:/tmp/pip-fKJiQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:10:50 INFO - Running setup.py (path:/tmp/pip-f4LmAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:10:50 INFO - Running setup.py (path:/tmp/pip-alQlUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:10:50 INFO - Running setup.py (path:/tmp/pip-VgR4Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:10:50 INFO - Running setup.py (path:/tmp/pip-juBwCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:10:50 INFO - Running setup.py (path:/tmp/pip-1Iya_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:10:50 INFO - Running setup.py (path:/tmp/pip-JvmtQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:10:51 INFO - Running setup.py (path:/tmp/pip-8Npwwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:10:51 INFO - Running setup.py (path:/tmp/pip-iuHIQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:10:51 INFO - Running setup.py (path:/tmp/pip-Kum8h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:10:51 INFO - Running setup.py (path:/tmp/pip-Tn8yZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:10:51 INFO - Running setup.py (path:/tmp/pip-ESIJWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:51 INFO - Running setup.py (path:/tmp/pip-74huod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:10:51 INFO - Running setup.py (path:/tmp/pip-MsYDMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:10:51 INFO - Running setup.py (path:/tmp/pip-IFo1nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:10:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:10:51 INFO - Running setup.py install for manifestparser 22:10:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:10:51 INFO - Running setup.py install for mozcrash 22:10:51 INFO - Running setup.py install for mozdebug 22:10:51 INFO - Running setup.py install for mozdevice 22:10:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozfile 22:10:52 INFO - Running setup.py install for mozhttpd 22:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozinfo 22:10:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozInstall 22:10:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozleak 22:10:52 INFO - Running setup.py install for mozlog 22:10:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for moznetwork 22:10:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozprocess 22:10:52 INFO - Running setup.py install for mozprofile 22:10:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:10:52 INFO - Running setup.py install for mozrunner 22:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Running setup.py install for mozscreenshot 22:10:53 INFO - Running setup.py install for moztest 22:10:53 INFO - Running setup.py install for mozversion 22:10:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:10:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:10:53 INFO - Cleaning up... 22:10:53 INFO - Return code: 0 22:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:53 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 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:53 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 22:10:53 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 22:10:53 INFO - Using env: {'DISPLAY': ':0', 22:10:53 INFO - 'HOME': '/home/cltbld', 22:10:53 INFO - 'LANG': 'en_US.UTF-8', 22:10:53 INFO - 'LANGUAGE': 'en_US:en', 22:10:53 INFO - 'LOGNAME': 'cltbld', 22:10:53 INFO - 'MAIL': '/var/mail/cltbld', 22:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:53 INFO - 'MOZ_NO_REMOTE': '1', 22:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:53 INFO - 'NO_EM_RESTART': '1', 22:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:53 INFO - 'PWD': '/builds/slave/test', 22:10:53 INFO - 'SHELL': '/bin/bash', 22:10:53 INFO - 'SHLVL': '1', 22:10:53 INFO - 'TERM': 'linux', 22:10:53 INFO - 'TMOUT': '86400', 22:10:53 INFO - 'USER': 'cltbld', 22:10:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:53 INFO - '_': '/tools/buildbot/bin/python'} 22:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:10:53 INFO - Running setup.py (path:/tmp/pip-pvfxny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:10:53 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)) 22:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:10:53 INFO - Running setup.py (path:/tmp/pip-NWsenO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:10:53 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)) 22:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:10:53 INFO - Running setup.py (path:/tmp/pip-h7U6x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:10:53 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)) 22:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:10:53 INFO - Running setup.py (path:/tmp/pip-lgfJAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:10:53 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)) 22:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:10:53 INFO - Running setup.py (path:/tmp/pip-PzSze5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:10:53 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)) 22:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:10:53 INFO - Running setup.py (path:/tmp/pip-uINfvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:10:54 INFO - Running setup.py (path:/tmp/pip-BZO9rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:10:54 INFO - Running setup.py (path:/tmp/pip-jSCbbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:10:54 INFO - Running setup.py (path:/tmp/pip-T486u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:10:54 INFO - Running setup.py (path:/tmp/pip-Q0AcpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:10:54 INFO - Running setup.py (path:/tmp/pip-Tga7_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:10:54 INFO - Running setup.py (path:/tmp/pip-M44F5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:10:54 INFO - Running setup.py (path:/tmp/pip-2pxFO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:10:54 INFO - Running setup.py (path:/tmp/pip-qmPQar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:54 INFO - Running setup.py (path:/tmp/pip-ylgARv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:10:54 INFO - Running setup.py (path:/tmp/pip-uDSpnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:10:54 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)) 22:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:10:54 INFO - Running setup.py (path:/tmp/pip-upGEoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:10:54 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)) 22:10:54 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)) 22:10:54 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)) 22:10:54 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)) 22:10:54 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)) 22:10:54 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)) 22:10:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10:56 INFO - Downloading blessings-1.6.tar.gz 22:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:10:56 INFO - Installing collected packages: blessings 22:10:56 INFO - Running setup.py install for blessings 22:10:56 INFO - Successfully installed blessings 22:10:56 INFO - Cleaning up... 22:10:56 INFO - Return code: 0 22:10:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:10:57 INFO - Reading from file tmpfile_stdout 22:10:57 INFO - Current package versions: 22:10:57 INFO - argparse == 1.2.1 22:10:57 INFO - blessings == 1.6 22:10:57 INFO - blobuploader == 1.2.4 22:10:57 INFO - docopt == 0.6.1 22:10:57 INFO - manifestparser == 1.1 22:10:57 INFO - mozInstall == 1.12 22:10:57 INFO - mozcrash == 0.17 22:10:57 INFO - mozdebug == 0.1 22:10:57 INFO - mozdevice == 0.48 22:10:57 INFO - mozfile == 1.2 22:10:57 INFO - mozhttpd == 0.7 22:10:57 INFO - mozinfo == 0.9 22:10:57 INFO - mozleak == 0.1 22:10:57 INFO - mozlog == 3.1 22:10:57 INFO - moznetwork == 0.27 22:10:57 INFO - mozprocess == 0.22 22:10:57 INFO - mozprofile == 0.28 22:10:57 INFO - mozrunner == 6.11 22:10:57 INFO - mozscreenshot == 0.1 22:10:57 INFO - mozsystemmonitor == 0.0 22:10:57 INFO - moztest == 0.7 22:10:57 INFO - mozversion == 1.4 22:10:57 INFO - psutil == 3.1.1 22:10:57 INFO - requests == 1.2.3 22:10:57 INFO - wsgiref == 0.1.2 22:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:57 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 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:57 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 22:10:57 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 22:10:57 INFO - Using env: {'DISPLAY': ':0', 22:10:57 INFO - 'HOME': '/home/cltbld', 22:10:57 INFO - 'LANG': 'en_US.UTF-8', 22:10:57 INFO - 'LANGUAGE': 'en_US:en', 22:10:57 INFO - 'LOGNAME': 'cltbld', 22:10:57 INFO - 'MAIL': '/var/mail/cltbld', 22:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:57 INFO - 'MOZ_NO_REMOTE': '1', 22:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:57 INFO - 'NO_EM_RESTART': '1', 22:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:57 INFO - 'PWD': '/builds/slave/test', 22:10:57 INFO - 'SHELL': '/bin/bash', 22:10:57 INFO - 'SHLVL': '1', 22:10:57 INFO - 'TERM': 'linux', 22:10:57 INFO - 'TMOUT': '86400', 22:10:57 INFO - 'USER': 'cltbld', 22:10:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:57 INFO - '_': '/tools/buildbot/bin/python'} 22:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 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)) 22:10:57 INFO - Cleaning up... 22:10:57 INFO - Return code: 0 22:10:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:10:57 INFO - Using env: {'DISPLAY': ':0', 22:10:57 INFO - 'HOME': '/home/cltbld', 22:10:57 INFO - 'LANG': 'en_US.UTF-8', 22:10:57 INFO - 'LANGUAGE': 'en_US:en', 22:10:57 INFO - 'LOGNAME': 'cltbld', 22:10:57 INFO - 'MAIL': '/var/mail/cltbld', 22:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:57 INFO - 'MOZ_NO_REMOTE': '1', 22:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:57 INFO - 'NO_EM_RESTART': '1', 22:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:57 INFO - 'PWD': '/builds/slave/test', 22:10:57 INFO - 'SHELL': '/bin/bash', 22:10:57 INFO - 'SHLVL': '1', 22:10:57 INFO - 'TERM': 'linux', 22:10:57 INFO - 'TMOUT': '86400', 22:10:57 INFO - 'USER': 'cltbld', 22:10:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:57 INFO - '_': '/tools/buildbot/bin/python'} 22:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:57 INFO - Downloading/unpacking jsonschema 22:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:10:59 INFO - Downloading/unpacking functools32 (from jsonschema) 22:10:59 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 22:10:59 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 22:10:59 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 22:10:59 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 22:10:59 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 22:10:59 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 22:10:59 INFO - Downloading functools32-3.2.3-2.tar.gz 22:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:10:59 INFO - warning: no files found matching '*.txt' 22:10:59 INFO - no previously-included directories found matching 'build' 22:10:59 INFO - no previously-included directories found matching 'dist' 22:10:59 INFO - no previously-included directories found matching '.git*' 22:10:59 INFO - Installing collected packages: jsonschema, functools32 22:10:59 INFO - Running setup.py install for functools32 22:10:59 INFO - warning: no files found matching '*.txt' 22:10:59 INFO - no previously-included directories found matching 'build' 22:10:59 INFO - no previously-included directories found matching 'dist' 22:10:59 INFO - no previously-included directories found matching '.git*' 22:10:59 INFO - Successfully installed jsonschema functools32 22:10:59 INFO - Cleaning up... 22:10:59 INFO - Return code: 0 22:10:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:59 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 0x7f0f1bd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, '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': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', '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 22:10:59 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 22:10:59 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 22:10:59 INFO - Using env: {'DISPLAY': ':0', 22:10:59 INFO - 'HOME': '/home/cltbld', 22:10:59 INFO - 'LANG': 'en_US.UTF-8', 22:10:59 INFO - 'LANGUAGE': 'en_US:en', 22:10:59 INFO - 'LOGNAME': 'cltbld', 22:10:59 INFO - 'MAIL': '/var/mail/cltbld', 22:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:59 INFO - 'MOZ_NO_REMOTE': '1', 22:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:59 INFO - 'NO_EM_RESTART': '1', 22:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:59 INFO - 'PWD': '/builds/slave/test', 22:10:59 INFO - 'SHELL': '/bin/bash', 22:10:59 INFO - 'SHLVL': '1', 22:10:59 INFO - 'TERM': 'linux', 22:10:59 INFO - 'TMOUT': '86400', 22:10:59 INFO - 'USER': 'cltbld', 22:10:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:59 INFO - '_': '/tools/buildbot/bin/python'} 22:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:00 INFO - Downloading/unpacking flake8 22:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:11:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:11:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 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 22:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:11:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:02 INFO - no previously-included directories found matching 'docs/_build' 22:11:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:11:02 INFO - Running setup.py install for pep8 22:11:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:02 INFO - no previously-included directories found matching 'docs/_build' 22:11:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:11:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:11:02 INFO - Cleaning up... 22:11:02 INFO - Return code: 0 22:11:02 INFO - Running post-action listener: _resource_record_post_action 22:11:02 INFO - Running post-action listener: _start_resource_monitoring 22:11:02 INFO - Starting resource monitoring. 22:11:02 INFO - ##### 22:11:02 INFO - ##### Running install step. 22:11:02 INFO - ##### 22:11:02 INFO - Running pre-action listener: _resource_record_pre_action 22:11:02 INFO - Running main action method: install 22:11:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:03 INFO - Reading from file tmpfile_stdout 22:11:03 INFO - Detecting whether we're running mozinstall >=1.0... 22:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:11:03 INFO - Reading from file tmpfile_stdout 22:11:03 INFO - Output received: 22:11:03 INFO - Usage: mozinstall [options] installer 22:11:03 INFO - Options: 22:11:03 INFO - -h, --help show this help message and exit 22:11:03 INFO - -d DEST, --destination=DEST 22:11:03 INFO - Directory to install application into. [default: 22:11:03 INFO - "/builds/slave/test"] 22:11:03 INFO - --app=APP Application being installed. [default: firefox] 22:11:03 INFO - mkdir: /builds/slave/test/build/application 22:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:11:18 INFO - Reading from file tmpfile_stdout 22:11:18 INFO - Output received: 22:11:18 INFO - /builds/slave/test/build/application/firefox/firefox 22:11:18 INFO - Running post-action listener: _resource_record_post_action 22:11:18 INFO - ##### 22:11:18 INFO - ##### Running run-tests step. 22:11:18 INFO - ##### 22:11:18 INFO - Running pre-action listener: _resource_record_pre_action 22:11:18 INFO - Running main action method: run_tests 22:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:11:18 INFO - Python 2.7.3 22:11:18 INFO - Return code: 0 22:11:18 INFO - grabbing minidump binary from tooltool 22:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e73410>, '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 0x1e74310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e747a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:11:18 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 22:11:18 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 22:11:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:11:19 INFO - Return code: 0 22:11:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:11:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:11:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:11:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:11:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:11:20 INFO - Return code: 0 22:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:11:20 INFO - Using env: {'DISPLAY': ':0', 22:11:20 INFO - 'HOME': '/home/cltbld', 22:11:20 INFO - 'LANG': 'en_US.UTF-8', 22:11:20 INFO - 'LANGUAGE': 'en_US:en', 22:11:20 INFO - 'LOGNAME': 'cltbld', 22:11:20 INFO - 'MAIL': '/var/mail/cltbld', 22:11:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:11:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:20 INFO - 'MOZ_NO_REMOTE': '1', 22:11:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:20 INFO - 'NO_EM_RESTART': '1', 22:11:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:20 INFO - 'PWD': '/builds/slave/test', 22:11:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:11:20 INFO - 'SHELL': '/bin/bash', 22:11:20 INFO - 'SHLVL': '1', 22:11:20 INFO - 'TERM': 'linux', 22:11:20 INFO - 'TMOUT': '86400', 22:11:20 INFO - 'USER': 'cltbld', 22:11:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461040802.438243-614595192', 22:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:20 INFO - '_': '/tools/buildbot/bin/python'} 22:11:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:11:20 INFO - mozversion application_buildid: 20160418205131 22:11:20 INFO - mozversion application_changeset: cb65ec85049efa44b18e2e8d06af26768c3bfb94 22:11:20 INFO - mozversion application_display_name: Nightly 22:11:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:11:20 INFO - mozversion application_name: Firefox 22:11:20 INFO - mozversion application_remotingname: firefox 22:11:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:11:20 INFO - mozversion application_vendor: Mozilla 22:11:20 INFO - mozversion application_version: 48.0a1 22:11:20 INFO - mozversion platform_buildid: 20160418205131 22:11:20 INFO - mozversion platform_changeset: cb65ec85049efa44b18e2e8d06af26768c3bfb94 22:11:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:11:20 INFO - mozversion platform_version: 48.0a1 22:11:20 INFO - using testdate: 1461042680 22:11:20 INFO - actual date: 1461042680 22:11:20 INFO - starting webserver on 'localhost:37992' 22:11:20 INFO - SUITE-START | Running 2 tests 22:11:20 INFO - TEST-START | dromaeo_css 22:11:20 INFO - operating with platform_type : linux_ 22:11:20 INFO - Initialising browser for dromaeo_css test... 22:11:20 INFO - TEST-INFO | started process 21144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaihUMm/profile http://localhost:37992/getInfo.html) 22:11:24 INFO - PROCESS | 21144 | 22:11:24 INFO - PROCESS | 21144 | (process:21212): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:11:26 INFO - PROCESS | 21144 | __metrics Screen width/height:1600/1200 22:11:26 INFO - PROCESS | 21144 | colorDepth:24 22:11:26 INFO - PROCESS | 21144 | Browser inner width/height: 1024/697 22:11:26 INFO - PROCESS | 21144 | __metrics 22:11:26 ERROR - PROCESS | 21144 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:11:27 INFO - TEST-INFO | 21144: exit 0 22:11:27 INFO - Browser initialized. 22:11:27 INFO - Running cycle 1/1 for dromaeo_css test... 22:11:27 INFO - TEST-INFO | started process 21264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaihUMm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:11:29 INFO - PROCESS | 21264 | 22:11:29 INFO - PROCESS | 21264 | (process:21323): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:11:39 INFO - PROCESS | 21264 | RSS: Main: 164409344 22:11:39 INFO - PROCESS | 21264 | 22:12:29 INFO - PROCESS | 21264 | 1461042749338 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] 22:14:41 INFO - PROCESS | 21264 | Cycle 1(1): loaded http://localhost:37992/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37992/tests/dromaeo/cssquery-ext.html) 22:14:42 INFO - PROCESS | 21264 | RSS: Main: 168939520 22:14:42 INFO - PROCESS | 21264 | 22:17:44 INFO - PROCESS | 21264 | Cycle 1(1): loaded http://localhost:37992/tests/dromaeo/cssquery-ext.html (next: http://localhost:37992/tests/dromaeo/cssquery-jquery.html) 22:17:44 INFO - PROCESS | 21264 | RSS: Main: 165646336 22:17:44 INFO - PROCESS | 21264 | 22:20:46 INFO - PROCESS | 21264 | Cycle 1(1): loaded http://localhost:37992/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37992/tests/dromaeo/cssquery-mootools.html) 22:20:47 INFO - PROCESS | 21264 | RSS: Main: 166682624 22:20:47 INFO - PROCESS | 21264 | 22:23:49 INFO - PROCESS | 21264 | Cycle 1(1): loaded http://localhost:37992/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37992/tests/dromaeo/cssquery-prototype.html) 22:23:49 INFO - PROCESS | 21264 | RSS: Main: 164454400 22:23:49 INFO - PROCESS | 21264 | 22:26:52 INFO - PROCESS | 21264 | Cycle 1(1): loaded http://localhost:37992/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37992/tests/dromaeo/cssquery-yui.html) 22:26:53 INFO - PROCESS | 21264 | RSS: Main: 165036032 22:26:53 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | Cycle 1(1): loaded http://localhost:37992/tests/dromaeo/cssquery-yui.html (next: http://localhost:37992/tests/dromaeo/cssquery-dojo.html) 22:29:55 INFO - PROCESS | 21264 | RSS: Main: 167378944 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | __start_tp_report 22:29:55 INFO - PROCESS | 21264 | _x_x_mozilla_page_load 22:29:55 INFO - PROCESS | 21264 | _x_x_mozilla_page_load_details 22:29:55 INFO - PROCESS | 21264 | |i|pagename|runs| 22:29:55 INFO - PROCESS | 21264 | |0;dojo.html;2635.3148181472816;2687.2207059952607;2723.346396864753;2732.7950403719724;2742.7668648164918;4710.528947105292;4734.43186817582;4737.028909073636;4748.453927798304;4802.519748025195;4650.860474185772;4736.928946065803;4754.334393184957;4820.084184005036;4827.662063655545;4350.521442641315;4441.689081764278;4444.177827101997;4451.799669014886;4455.532169122244;601.5948136923822;4237.576242375753;4344.587264209895;4374.03771170342;4382.991911860274;4321.0709697415205;4336;4337.414449049369;4347.391365208841;4380.671449641258;4220.6412454941365;4382.255016647177;4405.295152775572;4415.845445409395;4422.6240769534625;4291.227579035773;4304.160688665712;4333.783310834446;4342.348647702838;4364.258076127035;4621.329907163443;4666.743329116897;4686.461056978423;4687.273472611751;4733.077049975256;5077.136886729228;5081.364829396325;5097.923531146998;5114.667546609458;5149.150390185615;5060.721660308682;5066.847994560169;5067.847964561069;5079.060373830853;5094.617903657204;4730.219513780256;4735.550122738335;4756.048790241965;4761.642876784255;4796.232602783538;5049.343585333883;5139.871503212375;5237.266782650432;5273.182656688219;5304.177852432879;4968.900621987612;4990.90018199634;5008.949910500921;5021.14640511114;5033.144365457881;5095.796168153306;5102.336696229467;5103.464136265713;5110.718910459886;5159.793608255628;4940.654154209243;5044.344235249394;5076.162433198555;5126.333576635014;5181.896362072737;4808.3027960945465;5027.4469808321055;5072.898542029138;5074.467180945948;5097.235414687826;4245.490541135084;4272.252355837716;4272.829086836554;4313.0295683471595;4319.6112349888035;3649.908752281214;3731.197792474631;3741.7567858089137;3760.4547340636;3813.4089216171537;4410.316400957857;4449.065696203768;4458.9331160032625;4478.686491945533;4507.6619253555455;5147.0992576298995;5148.330717006766;5172.741362931838;5173.1722924331925;5204.193350030751;4325.286327755948;4401.493828209796;4439.511653718088;4466.419365482531;4482.372467854503;4504.09918016398;4534.886627834265;4538.092381523708;4538.6369090473345;4551.908961820811;4685.765711714469;4851.636127290538;4857.53853383928;4858;4903.583195428358;5071.13790655582;5105.974470127626;5151.6908985461;5158.819441319536;5192.584593232608;4771.95228047729;4798.256270278112;4806.47128815823;4815.422149342101;4831.227003679535;4899.485554016777;4986.7257300848805;5005.449400565862;5006;5050.444451110301;5054.16606259963;5076.441591424867;5078.593712503065;5086.9745651271505;5150.562202212854;4912.164931961646;4929.2359684248995;4939.975300123477;4940.283658869372;4952.727599982036;4797.4482934462985;4908.730019848943;4926.285688575065;4982.103221420034;4997.85006449807;4723.6929599575915;4811.133995880775;4867.80528778859;4886.169351210232;4902.779374928065;5012.398512178562;5030.698158110525;5037.319961805109;5040.84877453677;5090.745462726923;4878.658493905535;4905.975470122627;4925.581325587365;4936.925946110883;4961.751912404293 22:29:55 INFO - PROCESS | 21264 | |1;ext.html;579.50741869411;616.1650962945209;619.349682833025;627.034367074705;627.9372062793719;33505.66494335056;34376.65623343766;34700.1324966876;34736;34844.65155348446;34123.317533649315;35127.473087903636;35244.47133293003;35378;35444.2911141777;7474.327310542037;7598.506097103698;7610.885836712454;7637.427192960522;7652.19651936547;7401.444891633122;7569.394448444139;7589.316961473466;7612.771616851475;7634.961825190866;7552.055993000875;7636.541807491541;7641.7707468776025;7673.271039251262;7693.846123077563;7600.847983040336;7616.7334143305;7672.1560628330835;7677.846443071163;7698.846023079563;7697.384209263246;7707.845843083107;7717.498362606412;7756.6509507072315;7782.377409807202;29310.70689293101;33874.983750487525;34197.14507137317;34539.30921381583;34796.826015870014;2670.3858112634007;2672.5723884178633;2679.8660066996767;2836.0357478457217;2918.1099764571795;27089;27541.173764787087;27687.723122768715;27690.723092769014;27804.16587502378;3177.4280629486684;3192.984035079833;3217.8551965161623;3221.2269055426764;3236.72487838534;237253;241276.99999999825;242814;244558;245406;58074;58433.123503147486;58452.41547584555;58489.12266316009;58515.414845850995;61244.69377653083;62072.37927620666;63954;63970.202234831646;64215.6789216051;12403.317817520123;12410.069244806675;12468.75062498745;12494.687632809071;12556.560520381743;11206.775864482664;11312.490937907814;11324.886751132548;11355.148363872577;11368.886311136948;18863.151158197914;18935.242590296508;19068.523286917938;19119.235230590897;19660.50848728793;7404.666789994355;7611.543307401574;7638.350740187036;7777.5722335270975;7848.293653571206;926.4533924984291;970.9805803884024;1002.0830939690247;1016.0296916444778;1035.2597892506894;27625.447491050065;27986;28341.149765507067;28384.290392740346;28642.570361444596;965.3387429610739;993.9155171810477;1016.983016983017;1054.404261592198;1117.4133579870634;14572.271386430635;15018.249087545797;15111.924440377728;15355;15366.308516116802;320208;322395;326848;328002;328321;48276.27585586219;48839;49226.75386623044;49264.50735492671;49529;1215.3012018089635;1233.444949772606;1250.118666340228;1255.4225056474124;1259.6724851538665;26752.19743407701;27793.58309625317;27836.72163278422;28217;28319.29201769972;42114;42443.15113697647;42473;42877.356839648055;43028;289426;292642;293882;295034;295116;25583.6162457567;25863.353416164748;26079.348016299744;26165;26365.60451593266;41699;42385.36421953735;42540.787296063325;42657.36013959731;42762.5723742771;35653.82173089118;35776;35794.28411431809;36123.458148127276;36451.45322820213;34100;35889.82055089708;36670.633293666724;36943.44584831283;38427;34313.65686343204;34596;34604.30791384209;34796.30407391889;34901.12747181341;29522.261943451587;31613;31653.8417307912;31680;31722.68277317197;24438.14466493664;24467.510649787262;24834.875825620755;25179;25221.49557008813 22:29:55 INFO - PROCESS | 21264 | |2;jquery.html;377.8731000966998;381.70608631353844;387.1965671232193;393.6240889950098;400.9057871400222;15965.521034368972;17116.315347386106;17134.31462741489;17298.394556190506;17380.826191738095;15685.686286274296;16477.83522164778;16618.58453538659;16621.83378166218;16655.91672041641;3690.5940346561856;4801.423829140499;5090.669106508084;5118.846434606968;5126.051680439112;5529.917051244234;5873.471387575118;5887.087501437262;5905.055191169414;5905.704714764266;5647.548196144319;5836.941630583682;5853.414658534134;5858.443447872467;5928.170056192136;5884.911726324109;5909.6158749681135;5915.349311575723;5919.141724449953;5928.7628494860155;5142.948570514322;5173.586113110942;5203.375594928595;5288.048151332759;5301.443348448434;20834.27080052191;20854.47863803402;21062.157513699585;21330;21353.252636157817;1820.9089545522804;1853.8146185381488;1931.748872646547;2201;2247.898844551999;12688.238705677597;13007.479700811957;13062.608121756362;13065.412056457482;13476.25880576568;1621.9107949062798;1658.4858693804958;1666.758320043587;1719.7076496995417;1728.0754796184108;68922.31077689209;70924.29075709281;71132;71614.28385716128;71771;9407.482588457564;9651.179649729711;9825.606975721033;9905.752356191153;10045.296829221885;13449.798253026212;13523.59429217125;13638.454461821615;13690.863091369158;13717.588472345846;7269.273072692688;7339.77980660581;7494.625268736541;7509.399248060142;7538.057742782153;7331.816704582428;7408.85182296351;7419.925800741924;7626.161122276545;7658.4639075264195;5490.917636235459;6048.243969503812;6058.21243238385;6273.905891411632;6289.119523266746;1727.689015977111;1734.6097128146066;1789.91945362459;1790.2123065851245;1815.8184181581737;895.6596493332622;901.454619954931;928.2573940847295;947.2611363136764;1016.761061150629;16171.595710107342;16199.514014579581;16221.945573537681;16369.544568314848;16637.750433743502;936.489613160829;949.8554242138207;961.5144352102144;974.5565767575736;982.474376208725;9854.359466634645;9921.206303495703;9944.10503054714;10015.39907605546;10087;398678;401357;409152;411081;414196;68205.65897170482;69836.30163698299;71355;71633.2836671637;72601.6369918147;985.980280394388;993.761497240657;1003.0922015575916;1009.2531526670211;1017.9083882450615;15017.624559386102;15087.170205638795;15103.54689359321;15392.153431561372;15703.371865125268;31669.524957126123;32058.19854503656;32413.51379729353;33680.508858703965;34523.4821477673;43011.3548296782;43837.78081109574;44408.55591444044;44786.104277914914;45207.32189017233;7591.43064270193;7655.88516172269;7667.923320766721;7860.371170306476;7888.526688398714;8280;11128;11327.830082548604;11711.88288117142;11869.5845645402;7898.775689768095;8929.642814287616;9990.450525221182;10174.186065114922;10398.27212095146;9462.810743785223;10303.072723454925;10464.372137671764;10750.677479675622;10786.083182929226;10133.493325333851;10644.680659580225;10816.405097719386;11011.119110471303;11075.280106793032;7693.346065584488;7736.690532378641;7737.729179478692;7906.841863162589;7945.682172713258;10603.94698026505;10698.89301106979;10774.407407592658;10837.403942782907;10878.728031798952 22:29:55 INFO - PROCESS | 21264 | |3;mootools.html;1448.0659974316566;1481.1039321210667;1592.808862936448;1761.867859910507;1797.7662903822502;6984.406325462329;7733.265339792711;7810.17993110723;8089.716859909897;8118.147594502573;7688.231176882309;7712.498687585303;7769.223077692242;7769.417293702967;7823.374130069595;2232.653938639505;2272.8409011369213;2273.4202778291597;2280.1905323610126;2285.919992800252;2190.715207023085;2237.641977283635;2276.590213761522;2277.339571524256;2280.2589158523465;2253.267688001398;2271.114265436473;2283.292179424384;2296.9540609187807;2298.3564601911407;2165.9133634654595;2182.334388011656;2182.596219699353;2185.1041073160086;2189.8686078835162;2199.439143018536;2200.4938864061355;2208.8785116818567;2227.242737469252;2227.9554408911895;7943.64253608589;7979.082405523323;8000.079990801074;8000.319972802319;8041.396895232822;4667.15991121598;4764.190087685067;4809.470958194595;4819.783109760069;4825.613950883921;2925.2979284971666;2996.8801247950055;2999.355138645202;3027.197792584967;3038.437888990544;907.1155623267327;918.4994178172911;922.5654107862272;923.6813299411692;951.8810148731409;10552;10641.201909856793;10663.520141593646;10673;10693.091087257593;4198.9370159447635;4235.724677895927;4341;4439.62263207631;4450.532694067141;9174.908250917406;9175.265978721687;9181.77045573866;9185.494797786187;9204.033576474507;4811.735354555533;4813.7593120343845;4821.445533763592;4821.614270858323;4860.149473842134;3752.0432289765936;4218;4300.483941926988;4362.040351122748;4366.912661746747;3585.282943411276;3592.3892938200047;3652.1782598915033;3700.6669399753614;3709.146896213886;1221.194011952125;1224.2470880408484;1249.0507214517033;1252.2173641474078;1260.5021016698354;841.936854735885;845.7082306604211;853.3514528958036;861.2119910282022;870.508162887979;5232;5233.764480598382;5239.423663397023;5302.681839089667;5305.62860599762;419.6915267278548;424.4249042547366;424.83006797281337;425.6892468498014;428.79846472158033;3510.57873055235;3614.7469677122876;3618.909527261787;3620.6922411594783;3667.4132138857653;9339.486328252011;9699.757506062264;9754.512274386252;9856.605735770489;9863.852042219372;9639.277054220962;9649.517524123767;9716.708498745049;9727.270454715925;9738.659146929824;7134.928650713427;7371.631418429057;7372.336489715952;7423.591702456417;7454.434568740625;5254;5423.29497165366;5442.265294185393;5465.344158700981;5682.516986056232;8929.73210803677;8949.418287811272;9102.453852768855;9105.27157827359;9109.271258299452;9020.188183063556;9095.49974751395;9132.178103970675;9183.494907780136;9263.444193348421;6152.354002829818;6669.333066693292;6749.831254218684;6865.347791959756;6885.793426197222;7641.694332226649;7725.381969442544;7728.536287822523;7773.572453515111;7809.960950195213;6872.140982377203;7077.964610177122;7095;7116.573005619679;7141.535800172972;6957.2694867038235;6958.686859091252;6967.163940327193;7033.507654464139;7037.190723066708;6576.671166441754;6576.934230657632;6639.302873198245;6653.634050127096;6679.131712877295;4497.662675299301;4517.616002639812;4611.746353950565;4702.341672165968;4706.905861882811;4494.438195225597;4517.954820451753;4535.4103966484145;4558;4562.087582483583 22:29:55 INFO - PROCESS | 21264 | |4;prototype.html;300.55968006869944;312.62016649770527;319.7969289501166;320.8892931938482;322.098125249302;5092.974535127329;5216.765245563949;5227.137522308819;5239.633225674204;5274.551663108636;5265.447128051557;5272.657277276974;5282.366116066068;5292.417834038252;5321.4412486688825;4116.464859568267;4118.711690181688;4122;4122.42286079949;4126.834926602933;3866.883993480186;4092.406601042847;4134.545200027995;4146.792660366985;4147.419361289422;4005.698148101864;4038.3740520219267;4040.111175541391;4040.636342729154;4049.311617025113;3996.4005399190064;4037.454943582608;4039.919201615966;4041.737287076345;4067.4102255172834;3498.6676265754713;3503.7372197085065;3518.700910422617;3524.0793767396576;3539.699125574329;4802.615790736768;5025.271335656346;5062.670926389773;5085.338905942241;5095.006473737622;4625.098105869357;4648.372469716579;4653.906921861578;4663.650226233012;4663.813447462097;5571.4150014248735;5588.8423040982125;5591.580631452657;5595.153599312258;5602.495775380195;3785.470034195215;3855.20968201518;3863.497745293094;3868.941965870514;3870.1292209252974;5742.913856292159;5785.623934444247;5803.172000819771;5839.5036421904615;5839.9124013139835;3908.355121404936;3909.5308562972627;3927.410888366711;3936.3505021671103;3937.783421911822;3793.6585707285926;3966.682665386762;3977.7016723745833;3982.844974957288;3991.261616600938;4587.678862479661;4604.608608268268;4609.5799705154395;4618.630509559294;4624.861254162381;5238.319018527567;5497.285352904097;5511.614187006871;5534.418886016991;5550;1346.118292518402;1380.7100508893045;1384;1386.0713322074234;1394.1704685711986;913.2191975860676;920.5121285718579;934.5887809363858;941.5480569326761;951.3911096897991;4815.711057336501;4817.9518204817505;4821.63837712173;4827.131116399082;4833.3958255218095;5682.914756278659;5696.943030569724;5702.657840529581;5702.857428564319;5708.286464191976;4715.41057367829;4798.808047678123;4813.4945830687275;4820.156472617278;4823.866391398019;3057.357954829466;3071.2475443516037;3072.55447960049;3077.2306923269184;3088.6911308869385;5319.468053194727;5329.866753331198;5337.572994160458;5378.2470454136455;5395.676259424447;5659.179418984224;5802.912956305659;5810.94189058104;5833.300003999547;5850.64896106235;5314.202869569595;5332.893342133136;5342.572594192456;5359.598030147755;5371.731413429235;5438.721900353493;5625.606207565431;5649.802256920988;5688.687122208318;5699.5725320600295;5476.479734425223;5519.475649813261;5545.889082218414;5556.972215138899;5572;5238.214267859851;5280.683159010472;5304.552041173269;5307.708076055699;5316.192494551871;3725.8323375447626;3900.219956008753;3911.1395492991496;3918.568957414739;3921.7843018633107;5498.395176530658;5534.280543529316;5695.373508913934;5699.173619825019;5727.799527016535;5554.666719996813;5559.444055594408;5576.832695018994;5595.692236926845;5597.188407680945;5570.192322113352;5572.108462645957;5576.9163462547285;5590.608657393944;5603.8879222416135;5237.502437268454;5488.451154884479;5571.387147413862;5574.498295153456;5577.912307100077;5630.3525094613005;5670.432956704297;5672.43275672446;5676.574256930664;5707;5267.473252674702;5513.228148059195;5549.916751248816;5579.916301255404;5590.720463976866 22:29:55 INFO - PROCESS | 21264 | |5;yui.html;740.7740639105073;752.2665401233797;754.6302311867183;761.9657115429806;772.5905270206792;11119.166062545311;11129.610463633775;11181.776364472726;11238.66284011479;11279.661610151688;11094.334339939589;11098.944505277463;11148.554057837697;11154.330740155596;11205.439728013607;612.6416046612726;773.350385676032;789.1043665439738;791.7387262203488;797.5214871077366;781.6677911887454;786.4416264452245;789.3054112381096;789.6130895861015;789.7235967411417;839.0895877972407;840.2353857989231;843.784834867108;844.7212419901449;845.4800297816829;831.6507067031861;833.5332213960171;834.0658462521984;834.9958250208771;835.419383528448;612.9478994285491;614.0788816774838;614.5605891787393;615.1510914937403;616.8303716477959;11362.48868800906;11408;11442.885571144265;11445.656630301104;11503.367314797682;11760.70598235051;11874.821877671842;12041.217320874202;12209.267443953391;12524.123311368208;9624.855627165598;9751.3661611995;9792.363496372784;9835.606575737034;9898.10917017472;2969.346743716379;2975.895843645462;2992.7156920092557;3039.240189952512;3043.893463728759;47680.28479572809;48370.758146209395;49001.26498102531;49543.75228123836;49602.50397496015;9652.662156824477;9656.034396560288;9757.16083264807;9811.607535698493;10004.799904001879;16931.746023809654;16976.320947161974;17130.657386852192;17136.314547418213;17175.227114779864;6150.04674275488;6198.876022479525;6210.4410603045035;6228.532860035425;6323.083152942798;3373.5614370131725;3402.591688997287;3431.8455669494933;3480.8259587021053;3816;2707.0660622085347;2780.666320041608;2786.275568352243;2786.3312804926672;2792.748652621274;476.91177132229956;479.1367618670453;484.9854504364875;490.76933841094626;492.36730800920645;546.0164496094902;606.2815563557199;615.5045188623201;627.1721327847289;647.733923204355;7921.603919804102;8002.839943201104;8037.276645101969;8242.381821363422;8365.539895305696;520.7136075158647;557.7211394302849;607.5716619783042;608.2305883057935;619.0837560410617;3921.705872059607;3941.9802900985887;3968.980155099206;4103.753774773523;4284.400183974246;49352.50647493551;49355;49408.25887611689;49796;52437.213441798405;45402.09195816065;45753;46358;46635.53364466312;47671.28493072607;41930.161396772506;42244;42852;43016.139677206906;44143.55856441394;8174.7956301092945;8292.751217463485;8394.202550757669;8534.23191912706;8591;26971.730282697707;27191.86404067967;27237;28280.71719282863;28432.715672843005;37001.444978324806;39424.40863387109;39698.80150599228;39707;40033.399499006955;10535.947320263349;10540.420276884844;10560.313579617301;10622.097121744739;10726.946365268124;11878.109141814226;12207.938960305142;12346.567870124503;12400.689982750142;12463.252204867737;10548.103411210133;10649.787004260026;10693.14454843595;11094;11197.328160310408;9877.555510001923;10058.497075146068;10133.594656213669;10159.390436573829;10274.691759247235;10626.203034772578;10662.253642244968;10681.89318106809;10794.298370605886;10806.135509159405;9195.954020229856;9222.723318300461;9509.809803804024;9565.378250413702;9809.656662016796;9533.427994320364;9769.364991275545;9783.119519243302;9857.901420985985;9903.702888913343 22:29:55 INFO - PROCESS | 21264 | __end_tp_report 22:29:55 INFO - PROCESS | 21264 | __start_cc_report 22:29:55 INFO - PROCESS | 21264 | _x_x_mozilla_cycle_collect,365 22:29:55 INFO - PROCESS | 21264 | __end_cc_report 22:29:55 INFO - PROCESS | 21264 | __startTimestamp1461043795665__endTimestamp 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | ------- Summary: start ------- 22:29:55 INFO - PROCESS | 21264 | Number of tests: 6 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | [#0] dojo.html Cycles:165 Average:4679.11 Median:4827.66 stddev:585.65 (12.1%) stddev-sans-first:565.07 22:29:55 INFO - PROCESS | 21264 | Values: 2635.3 2687.2 2723.3 2732.8 2742.8 4710.5 4734.4 4737.0 4748.5 4802.5 4650.9 4736.9 4754.3 4820.1 4827.7 4350.5 4441.7 4444.2 4451.8 4455.5 601.6 4237.6 4344.6 4374.0 4383.0 4321.1 4336.0 4337.4 4347.4 4380.7 4220.6 4382.3 4405.3 4415.8 4422.6 4291.2 4304.2 4333.8 4342.3 4364.3 4621.3 4666.7 4686.5 4687.3 4733.1 5077.1 5081.4 5097.9 5114.7 5149.2 5060.7 5066.8 5067.8 5079.1 5094.6 4730.2 4735.6 4756.0 4761.6 4796.2 5049.3 5139.9 5237.3 5273.2 5304.2 4968.9 4990.9 5008.9 5021.1 5033.1 5095.8 5102.3 5103.5 5110.7 5159.8 4940.7 5044.3 5076.2 5126.3 5181.9 4808.3 5027.4 5072.9 5074.5 5097.2 4245.5 4272.3 4272.8 4313.0 4319.6 3649.9 3731.2 3741.8 3760.5 3813.4 4410.3 4449.1 4458.9 4478.7 4507.7 5147.1 5148.3 5172.7 5173.2 5204.2 4325.3 4401.5 4439.5 4466.4 4482.4 4504.1 4534.9 4538.1 4538.6 4551.9 4685.8 4851.6 4857.5 4858.0 4903.6 5071.1 5106.0 5151.7 5158.8 5192.6 4772.0 4798.3 4806.5 4815.4 4831.2 4899.5 4986.7 5005.4 5006.0 5050.4 5054.2 5076.4 5078.6 5087.0 5150.6 4912.2 4929.2 4940.0 4940.3 4952.7 4797.4 4908.7 4926.3 4982.1 4997.9 4723.7 4811.1 4867.8 4886.2 4902.8 5012.4 5030.7 5037.3 5040.8 5090.7 4878.7 4906.0 4925.6 4936.9 4961.8 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | [#1] ext.html Cycles:180 Average:44591.26 Median:34160.23 stddev:75753.62 (221.8%) stddev-sans-first:75894.05 22:29:55 INFO - PROCESS | 21264 | Values: 579.5 616.2 619.3 627.0 627.9 33505.7 34376.7 34700.1 34736.0 34844.7 34123.3 35127.5 35244.5 35378.0 35444.3 7474.3 7598.5 7610.9 7637.4 7652.2 7401.4 7569.4 7589.3 7612.8 7635.0 7552.1 7636.5 7641.8 7673.3 7693.8 7600.8 7616.7 7672.2 7677.8 7698.8 7697.4 7707.8 7717.5 7756.7 7782.4 29310.7 33875.0 34197.1 34539.3 34796.8 2670.4 2672.6 2679.9 2836.0 2918.1 27089.0 27541.2 27687.7 27690.7 27804.2 3177.4 3193.0 3217.9 3221.2 3236.7 237253.0 241277.0 242814.0 244558.0 245406.0 58074.0 58433.1 58452.4 58489.1 58515.4 61244.7 62072.4 63954.0 63970.2 64215.7 12403.3 12410.1 12468.8 12494.7 12556.6 11206.8 11312.5 11324.9 11355.1 11368.9 18863.2 18935.2 19068.5 19119.2 19660.5 7404.7 7611.5 7638.4 7777.6 7848.3 926.5 971.0 1002.1 1016.0 1035.3 27625.4 27986.0 28341.1 28384.3 28642.6 965.3 993.9 1017.0 1054.4 1117.4 14572.3 15018.2 15111.9 15355.0 15366.3 320208.0 322395.0 326848.0 328002.0 328321.0 48276.3 48839.0 49226.8 49264.5 49529.0 1215.3 1233.4 1250.1 1255.4 1259.7 26752.2 27793.6 27836.7 28217.0 28319.3 42114.0 42443.2 42473.0 42877.4 43028.0 289426.0 292642.0 293882.0 295034.0 295116.0 25583.6 25863.4 26079.3 26165.0 26365.6 41699.0 42385.4 42540.8 42657.4 42762.6 35653.8 35776.0 35794.3 36123.5 36451.5 34100.0 35889.8 36670.6 36943.4 38427.0 34313.7 34596.0 34604.3 34796.3 34901.1 29522.3 31613.0 31653.8 31680.0 31722.7 24438.1 24467.5 24834.9 25179.0 25221.5 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | [#2] jquery.html Cycles:180 Average:24528.85 Median:410116.50 stddev:66861.31 (16.3%) stddev-sans-first:67024.28 22:29:55 INFO - PROCESS | 21264 | Values: 377.9 381.7 387.2 393.6 400.9 15965.5 17116.3 17134.3 17298.4 17380.8 15685.7 16477.8 16618.6 16621.8 16655.9 3690.6 4801.4 5090.7 5118.8 5126.1 5529.9 5873.5 5887.1 5905.1 5905.7 5647.5 5836.9 5853.4 5858.4 5928.2 5884.9 5909.6 5915.3 5919.1 5928.8 5142.9 5173.6 5203.4 5288.0 5301.4 20834.3 20854.5 21062.2 21330.0 21353.3 1820.9 1853.8 1931.7 2201.0 2247.9 12688.2 13007.5 13062.6 13065.4 13476.3 1621.9 1658.5 1666.8 1719.7 1728.1 68922.3 70924.3 71132.0 71614.3 71771.0 9407.5 9651.2 9825.6 9905.8 10045.3 13449.8 13523.6 13638.5 13690.9 13717.6 7269.3 7339.8 7494.6 7509.4 7538.1 7331.8 7408.9 7419.9 7626.2 7658.5 5490.9 6048.2 6058.2 6273.9 6289.1 1727.7 1734.6 1789.9 1790.2 1815.8 895.7 901.5 928.3 947.3 1016.8 16171.6 16199.5 16221.9 16369.5 16637.8 936.5 949.9 961.5 974.6 982.5 9854.4 9921.2 9944.1 10015.4 10087.0 398678.0 401357.0 409152.0 411081.0 414196.0 68205.7 69836.3 71355.0 71633.3 72601.6 986.0 993.8 1003.1 1009.3 1017.9 15017.6 15087.2 15103.5 15392.2 15703.4 31669.5 32058.2 32413.5 33680.5 34523.5 43011.4 43837.8 44408.6 44786.1 45207.3 7591.4 7655.9 7667.9 7860.4 7888.5 8280.0 11128.0 11327.8 11711.9 11869.6 7898.8 8929.6 9990.5 10174.2 10398.3 9462.8 10303.1 10464.4 10750.7 10786.1 10133.5 10644.7 10816.4 11011.1 11075.3 7693.3 7736.7 7737.7 7906.8 7945.7 10603.9 10698.9 10774.4 10837.4 10878.7 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | [#3] mootools.html Cycles:180 Average:5217.44 Median:5232.88 stddev:2916.17 (55.7%) stddev-sans-first:2910.59 22:29:55 INFO - PROCESS | 21264 | Values: 1448.1 1481.1 1592.8 1761.9 1797.8 6984.4 7733.3 7810.2 8089.7 8118.1 7688.2 7712.5 7769.2 7769.4 7823.4 2232.7 2272.8 2273.4 2280.2 2285.9 2190.7 2237.6 2276.6 2277.3 2280.3 2253.3 2271.1 2283.3 2297.0 2298.4 2165.9 2182.3 2182.6 2185.1 2189.9 2199.4 2200.5 2208.9 2227.2 2228.0 7943.6 7979.1 8000.1 8000.3 8041.4 4667.2 4764.2 4809.5 4819.8 4825.6 2925.3 2996.9 2999.4 3027.2 3038.4 907.1 918.5 922.6 923.7 951.9 10552.0 10641.2 10663.5 10673.0 10693.1 4198.9 4235.7 4341.0 4439.6 4450.5 9174.9 9175.3 9181.8 9185.5 9204.0 4811.7 4813.8 4821.4 4821.6 4860.1 3752.0 4218.0 4300.5 4362.0 4366.9 3585.3 3592.4 3652.2 3700.7 3709.1 1221.2 1224.2 1249.1 1252.2 1260.5 841.9 845.7 853.4 861.2 870.5 5232.0 5233.8 5239.4 5302.7 5305.6 419.7 424.4 424.8 425.7 428.8 3510.6 3614.7 3618.9 3620.7 3667.4 9339.5 9699.8 9754.5 9856.6 9863.9 9639.3 9649.5 9716.7 9727.3 9738.7 7134.9 7371.6 7372.3 7423.6 7454.4 5254.0 5423.3 5442.3 5465.3 5682.5 8929.7 8949.4 9102.5 9105.3 9109.3 9020.2 9095.5 9132.2 9183.5 9263.4 6152.4 6669.3 6749.8 6865.3 6885.8 7641.7 7725.4 7728.5 7773.6 7810.0 6872.1 7078.0 7095.0 7116.6 7141.5 6957.3 6958.7 6967.2 7033.5 7037.2 6576.7 6576.9 6639.3 6653.6 6679.1 4497.7 4517.6 4611.7 4702.3 4706.9 4494.4 4518.0 4535.4 4558.0 4562.1 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | [#4] prototype.html Cycles:180 Average:4566.85 Median:5238.98 stddev:1347.88 (25.7%) stddev-sans-first:1313.07 22:29:55 INFO - PROCESS | 21264 | Values: 300.6 312.6 319.8 320.9 322.1 5093.0 5216.8 5227.1 5239.6 5274.6 5265.4 5272.7 5282.4 5292.4 5321.4 4116.5 4118.7 4122.0 4122.4 4126.8 3866.9 4092.4 4134.5 4146.8 4147.4 4005.7 4038.4 4040.1 4040.6 4049.3 3996.4 4037.5 4039.9 4041.7 4067.4 3498.7 3503.7 3518.7 3524.1 3539.7 4802.6 5025.3 5062.7 5085.3 5095.0 4625.1 4648.4 4653.9 4663.7 4663.8 5571.4 5588.8 5591.6 5595.2 5602.5 3785.5 3855.2 3863.5 3868.9 3870.1 5742.9 5785.6 5803.2 5839.5 5839.9 3908.4 3909.5 3927.4 3936.4 3937.8 3793.7 3966.7 3977.7 3982.8 3991.3 4587.7 4604.6 4609.6 4618.6 4624.9 5238.3 5497.3 5511.6 5534.4 5550.0 1346.1 1380.7 1384.0 1386.1 1394.2 913.2 920.5 934.6 941.5 951.4 4815.7 4818.0 4821.6 4827.1 4833.4 5682.9 5696.9 5702.7 5702.9 5708.3 4715.4 4798.8 4813.5 4820.2 4823.9 3057.4 3071.2 3072.6 3077.2 3088.7 5319.5 5329.9 5337.6 5378.2 5395.7 5659.2 5802.9 5810.9 5833.3 5850.6 5314.2 5332.9 5342.6 5359.6 5371.7 5438.7 5625.6 5649.8 5688.7 5699.6 5476.5 5519.5 5545.9 5557.0 5572.0 5238.2 5280.7 5304.6 5307.7 5316.2 3725.8 3900.2 3911.1 3918.6 3921.8 5498.4 5534.3 5695.4 5699.2 5727.8 5554.7 5559.4 5576.8 5595.7 5597.2 5570.2 5572.1 5576.9 5590.6 5603.9 5237.5 5488.5 5571.4 5574.5 5577.9 5630.4 5670.4 5672.4 5676.6 5707.0 5267.5 5513.2 5549.9 5579.9 5590.7 22:29:55 INFO - PROCESS | 21264 | 22:29:55 INFO - PROCESS | 21264 | [#5] yui.html Cycles:180 Average:12595.38 Median:47675.78 stddev:14458.35 (30.3%) stddev-sans-first:14471.50 22:29:55 INFO - PROCESS | 21264 | Values: 740.8 752.3 754.6 762.0 772.6 11119.2 11129.6 11181.8 11238.7 11279.7 11094.3 11098.9 11148.6 11154.3 11205.4 612.6 773.4 789.1 791.7 797.5 781.7 786.4 789.3 789.6 789.7 839.1 840.2 843.8 844.7 845.5 831.7 833.5 834.1 835.0 835.4 612.9 614.1 614.6 615.2 616.8 11362.5 11408.0 11442.9 11445.7 11503.4 11760.7 11874.8 12041.2 12209.3 12524.1 9624.9 9751.4 9792.4 9835.6 9898.1 2969.3 2975.9 2992.7 3039.2 3043.9 47680.3 48370.8 49001.3 49543.8 49602.5 9652.7 9656.0 9757.2 9811.6 10004.8 16931.7 16976.3 17130.7 17136.3 17175.2 6150.0 6198.9 6210.4 6228.5 6323.1 3373.6 3402.6 3431.8 3480.8 3816.0 2707.1 2780.7 2786.3 2786.3 2792.7 476.9 479.1 485.0 490.8 492.4 546.0 606.3 615.5 627.2 647.7 7921.6 8002.8 8037.3 8242.4 8365.5 520.7 557.7 607.6 608.2 619.1 3921.7 3942.0 3969.0 4103.8 4284.4 49352.5 49355.0 49408.3 49796.0 52437.2 45402.1 45753.0 46358.0 46635.5 47671.3 41930.2 42244.0 42852.0 43016.1 44143.6 8174.8 8292.8 8394.2 8534.2 8591.0 26971.7 27191.9 27237.0 28280.7 28432.7 37001.4 39424.4 39698.8 39707.0 40033.4 10535.9 10540.4 10560.3 10622.1 10726.9 11878.1 12207.9 12346.6 12400.7 12463.3 10548.1 10649.8 10693.1 11094.0 11197.3 9877.6 10058.5 10133.6 10159.4 10274.7 10626.2 10662.3 10681.9 10794.3 10806.1 9196.0 9222.7 9509.8 9565.4 9809.7 9533.4 9769.4 9783.1 9857.9 9903.7 22:29:55 INFO - PROCESS | 21264 | -------- Summary: end -------- 22:29:55 INFO - PROCESS | 21264 | 22:29:56 INFO - TEST-INFO | 21264: exit 0 22:29:56 INFO - TEST-OK | dromaeo_css | took 1116199ms 22:29:56 INFO - TEST-START | kraken 22:29:56 INFO - operating with platform_type : linux_ 22:29:56 INFO - Initialising browser for kraken test... 22:29:56 INFO - TEST-INFO | started process 21498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKEB27H/profile http://localhost:37992/getInfo.html) 22:30:00 INFO - PROCESS | 21498 | 22:30:00 INFO - PROCESS | 21498 | (process:21566): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:30:01 INFO - PROCESS | 21498 | __metrics Screen width/height:1600/1200 22:30:01 INFO - PROCESS | 21498 | colorDepth:24 22:30:01 INFO - PROCESS | 21498 | Browser inner width/height: 1024/697 22:30:01 INFO - PROCESS | 21498 | __metrics 22:30:02 ERROR - PROCESS | 21498 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:30:03 INFO - TEST-INFO | 21498: exit 0 22:30:03 INFO - Browser initialized. 22:30:03 INFO - Running cycle 1/1 for kraken test... 22:30:03 INFO - TEST-INFO | started process 21617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKEB27H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:05 INFO - PROCESS | 21617 | 22:30:05 INFO - PROCESS | 21617 | (process:21677): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:30:15 INFO - PROCESS | 21617 | RSS: Main: 164503552 22:30:15 INFO - PROCESS | 21617 | 22:30:18 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37992/tests/kraken/driver.html?testName=audio-beat-detection) 22:30:19 INFO - PROCESS | 21617 | RSS: Main: 168284160 22:30:19 INFO - PROCESS | 21617 | 22:30:22 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37992/tests/kraken/driver.html?testName=audio-dft) 22:30:22 INFO - PROCESS | 21617 | RSS: Main: 172232704 22:30:22 INFO - PROCESS | 21617 | 22:30:25 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37992/tests/kraken/driver.html?testName=audio-fft) 22:30:26 INFO - PROCESS | 21617 | RSS: Main: 163414016 22:30:26 INFO - PROCESS | 21617 | 22:30:28 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37992/tests/kraken/driver.html?testName=audio-oscillator) 22:30:28 INFO - PROCESS | 21617 | RSS: Main: 164057088 22:30:28 INFO - PROCESS | 21617 | 22:30:31 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37992/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:30:31 INFO - PROCESS | 21617 | RSS: Main: 164233216 22:30:31 INFO - PROCESS | 21617 | 22:30:35 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37992/tests/kraken/driver.html?testName=imaging-darkroom) 22:30:35 INFO - PROCESS | 21617 | RSS: Main: 164569088 22:30:35 INFO - PROCESS | 21617 | 22:30:39 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37992/tests/kraken/driver.html?testName=imaging-desaturate) 22:30:39 INFO - PROCESS | 21617 | RSS: Main: 164487168 22:30:39 INFO - PROCESS | 21617 | 22:30:42 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37992/tests/kraken/driver.html?testName=json-parse-financial) 22:30:43 INFO - PROCESS | 21617 | RSS: Main: 164450304 22:30:43 INFO - PROCESS | 21617 | 22:30:45 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37992/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:30:45 INFO - PROCESS | 21617 | RSS: Main: 164716544 22:30:45 INFO - PROCESS | 21617 | 22:30:47 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:30:48 INFO - PROCESS | 21617 | RSS: Main: 164302848 22:30:48 INFO - PROCESS | 21617 | 22:30:50 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:30:51 INFO - PROCESS | 21617 | RSS: Main: 164601856 22:30:51 INFO - PROCESS | 21617 | 22:30:53 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:30:54 INFO - PROCESS | 21617 | RSS: Main: 164925440 22:30:54 INFO - PROCESS | 21617 | 22:30:57 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:30:58 INFO - PROCESS | 21617 | RSS: Main: 164970496 22:30:58 INFO - PROCESS | 21617 | 22:30:59 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:37992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37992/tests/kraken/driver.html?testName=ai-astar) 22:31:00 INFO - PROCESS | 21617 | RSS: Main: 167522304 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | __start_tp_report 22:31:00 INFO - PROCESS | 21617 | _x_x_mozilla_page_load 22:31:00 INFO - PROCESS | 21617 | _x_x_mozilla_page_load_details 22:31:00 INFO - PROCESS | 21617 | |i|pagename|runs| 22:31:00 INFO - PROCESS | 21617 | |0;ai-astar;113;107;114;113;113;126;116;116;117;112 22:31:00 INFO - PROCESS | 21617 | |1;audio-beat-detection;158;134;158;200;133;164;165;136;190;134 22:31:00 INFO - PROCESS | 21617 | |2;audio-dft;163;167;163;174;164;163;163;164;165;163 22:31:00 INFO - PROCESS | 21617 | |3;audio-fft;78;74;75;160;80;74;74;77;155;77 22:31:00 INFO - PROCESS | 21617 | |4;audio-oscillator;92;98;146;94;96;93;141;94;94;136 22:31:00 INFO - PROCESS | 21617 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;121;118 22:31:00 INFO - PROCESS | 21617 | |6;imaging-darkroom;149;148;149;148;148;147;149;147;148;148 22:31:00 INFO - PROCESS | 21617 | |7;imaging-desaturate;96;96;95;96;96;95;95;96;96;95 22:31:00 INFO - PROCESS | 21617 | |8;json-parse-financial;64;64;65;63;66;64;67;78;63;64 22:31:00 INFO - PROCESS | 21617 | |9;json-stringify-tinderbox;65;66;65;65;65;64;64;67;66;65 22:31:00 INFO - PROCESS | 21617 | |10;stanford-crypto-aes;79;79;80;79;80;81;81;81;82;88 22:31:00 INFO - PROCESS | 21617 | |11;stanford-crypto-ccm;136;134;141;134;133;147;145;135;166;136 22:31:00 INFO - PROCESS | 21617 | |12;stanford-crypto-pbkdf2;181;177;179;178;184;177;182;182;176;174 22:31:00 INFO - PROCESS | 21617 | |13;stanford-crypto-sha256-iterative;75;73;76;72;72;75;72;72;73;73 22:31:00 INFO - PROCESS | 21617 | __end_tp_report 22:31:00 INFO - PROCESS | 21617 | __start_cc_report 22:31:00 INFO - PROCESS | 21617 | _x_x_mozilla_cycle_collect,954 22:31:00 INFO - PROCESS | 21617 | __end_cc_report 22:31:00 INFO - PROCESS | 21617 | __startTimestamp1461043860247__endTimestamp 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | ------- Summary: start ------- 22:31:00 INFO - PROCESS | 21617 | Number of tests: 14 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:4.85 (4.2%) stddev-sans-first:5.11 22:31:00 INFO - PROCESS | 21617 | Values: 113.0 107.0 114.0 113.0 113.0 126.0 116.0 116.0 117.0 112.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:161.00 stddev:23.87 (14.8%) stddev-sans-first:25.32 22:31:00 INFO - PROCESS | 21617 | Values: 158.0 134.0 158.0 200.0 133.0 164.0 165.0 136.0 190.0 134.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.45 (2.1%) stddev-sans-first:3.59 22:31:00 INFO - PROCESS | 21617 | Values: 163.0 167.0 163.0 174.0 164.0 163.0 163.0 164.0 165.0 163.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:34.39 (45.2%) stddev-sans-first:36.08 22:31:00 INFO - PROCESS | 21617 | Values: 78.0 74.0 75.0 160.0 80.0 74.0 74.0 77.0 155.0 77.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:22.68 (24.1%) stddev-sans-first:23.26 22:31:00 INFO - PROCESS | 21617 | Values: 92.0 98.0 146.0 94.0 96.0 93.0 141.0 94.0 94.0 136.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.27 22:31:00 INFO - PROCESS | 21617 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 121.0 118.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 22:31:00 INFO - PROCESS | 21617 | Values: 149.0 148.0 149.0 148.0 148.0 147.0 149.0 147.0 148.0 148.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:31:00 INFO - PROCESS | 21617 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:64.50 stddev:4.47 (6.9%) stddev-sans-first:4.69 22:31:00 INFO - PROCESS | 21617 | Values: 64.0 64.0 65.0 63.0 66.0 64.0 67.0 78.0 63.0 64.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 22:31:00 INFO - PROCESS | 21617 | Values: 65.0 66.0 65.0 65.0 65.0 64.0 64.0 67.0 66.0 65.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:2.67 (3.3%) stddev-sans-first:2.73 22:31:00 INFO - PROCESS | 21617 | Values: 79.0 79.0 80.0 79.0 80.0 81.0 81.0 81.0 82.0 88.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:138.50 stddev:10.13 (7.3%) stddev-sans-first:10.60 22:31:00 INFO - PROCESS | 21617 | Values: 136.0 134.0 141.0 134.0 133.0 147.0 145.0 135.0 166.0 136.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:180.00 stddev:3.16 (1.8%) stddev-sans-first:3.27 22:31:00 INFO - PROCESS | 21617 | Values: 181.0 177.0 179.0 178.0 184.0 177.0 182.0 182.0 176.0 174.0 22:31:00 INFO - PROCESS | 21617 | 22:31:00 INFO - PROCESS | 21617 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.00 stddev:1.49 (2.0%) stddev-sans-first:1.45 22:31:00 INFO - PROCESS | 21617 | Values: 75.0 73.0 76.0 72.0 72.0 75.0 72.0 72.0 73.0 73.0 22:31:00 INFO - PROCESS | 21617 | -------- Summary: end -------- 22:31:00 INFO - PROCESS | 21617 | 22:31:01 INFO - TEST-INFO | 21617: exit 0 22:31:01 INFO - TEST-OK | kraken | took 65097ms 22:31:01 INFO - SUITE-END | took 1181s 22:31:01 INFO - Completed test suite (00:19:41) 22:31:01 INFO - javascript benchmark 22:31:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.3148181472816, 2687.2207059952607, 2723.346396864753, 2732.7950403719724, 2742.7668648164918, 4710.528947105292, 4734.43186817582, 4737.028909073636, 4748.453927798304, 4802.519748025195, 4650.860474185772, 4736.928946065803, 4754.334393184957, 4820.084184005036, 4827.662063655545, 4350.521442641315, 4441.689081764278, 4444.177827101997, 4451.799669014886, 4455.532169122244, 601.5948136923822, 4237.576242375753, 4344.587264209895, 4374.03771170342, 4382.991911860274, 4321.0709697415205, 4336.0, 4337.414449049369, 4347.391365208841, 4380.671449641258, 4220.6412454941365, 4382.255016647177, 4405.295152775572, 4415.845445409395, 4422.6240769534625, 4291.227579035773, 4304.160688665712, 4333.783310834446, 4342.348647702838, 4364.258076127035, 4621.329907163443, 4666.743329116897, 4686.461056978423, 4687.273472611751, 4733.077049975256, 5077.136886729228, 5081.364829396325, 5097.923531146998, 5114.667546609458, 5149.150390185615, 5060.721660308682, 5066.847994560169, 5067.847964561069, 5079.060373830853, 5094.617903657204, 4730.219513780256, 4735.550122738335, 4756.048790241965, 4761.642876784255, 4796.232602783538, 5049.343585333883, 5139.871503212375, 5237.266782650432, 5273.182656688219, 5304.177852432879, 4968.900621987612, 4990.90018199634, 5008.949910500921, 5021.14640511114, 5033.144365457881, 5095.796168153306, 5102.336696229467, 5103.464136265713, 5110.718910459886, 5159.793608255628, 4940.654154209243, 5044.344235249394, 5076.162433198555, 5126.333576635014, 5181.896362072737, 4808.3027960945465, 5027.4469808321055, 5072.898542029138, 5074.467180945948, 5097.235414687826, 4245.490541135084, 4272.252355837716, 4272.829086836554, 4313.0295683471595, 4319.6112349888035, 3649.908752281214, 3731.197792474631, 3741.7567858089137, 3760.4547340636, 3813.4089216171537, 4410.316400957857, 4449.065696203768, 4458.9331160032625, 4478.686491945533, 4507.6619253555455, 5147.0992576298995, 5148.330717006766, 5172.741362931838, 5173.1722924331925, 5204.193350030751, 4325.286327755948, 4401.493828209796, 4439.511653718088, 4466.419365482531, 4482.372467854503, 4504.09918016398, 4534.886627834265, 4538.092381523708, 4538.6369090473345, 4551.908961820811, 4685.765711714469, 4851.636127290538, 4857.53853383928, 4858.0, 4903.583195428358, 5071.13790655582, 5105.974470127626, 5151.6908985461, 5158.819441319536, 5192.584593232608, 4771.95228047729, 4798.256270278112, 4806.47128815823, 4815.422149342101, 4831.227003679535, 4899.485554016777, 4986.7257300848805, 5005.449400565862, 5006.0, 5050.444451110301, 5054.16606259963, 5076.441591424867, 5078.593712503065, 5086.9745651271505, 5150.562202212854, 4912.164931961646, 4929.2359684248995, 4939.975300123477, 4940.283658869372, 4952.727599982036, 4797.4482934462985, 4908.730019848943, 4926.285688575065, 4982.103221420034, 4997.85006449807, 4723.6929599575915, 4811.133995880775, 4867.80528778859, 4886.169351210232, 4902.779374928065, 5012.398512178562, 5030.698158110525, 5037.319961805109, 5040.84877453677, 5090.745462726923, 4878.658493905535, 4905.975470122627, 4925.581325587365, 4936.925946110883, 4961.751912404293], "value": 4644.14076173763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.50741869411, 616.1650962945209, 619.349682833025, 627.034367074705, 627.9372062793719, 33505.66494335056, 34376.65623343766, 34700.1324966876, 34736.0, 34844.65155348446, 34123.317533649315, 35127.473087903636, 35244.47133293003, 35378.0, 35444.2911141777, 7474.327310542037, 7598.506097103698, 7610.885836712454, 7637.427192960522, 7652.19651936547, 7401.444891633122, 7569.394448444139, 7589.316961473466, 7612.771616851475, 7634.961825190866, 7552.055993000875, 7636.541807491541, 7641.7707468776025, 7673.271039251262, 7693.846123077563, 7600.847983040336, 7616.7334143305, 7672.1560628330835, 7677.846443071163, 7698.846023079563, 7697.384209263246, 7707.845843083107, 7717.498362606412, 7756.6509507072315, 7782.377409807202, 29310.70689293101, 33874.983750487525, 34197.14507137317, 34539.30921381583, 34796.826015870014, 2670.3858112634007, 2672.5723884178633, 2679.8660066996767, 2836.0357478457217, 2918.1099764571795, 27089.0, 27541.173764787087, 27687.723122768715, 27690.723092769014, 27804.16587502378, 3177.4280629486684, 3192.984035079833, 3217.8551965161623, 3221.2269055426764, 3236.72487838534, 237253.0, 241276.99999999825, 242814.0, 244558.0, 245406.0, 58074.0, 58433.123503147486, 58452.41547584555, 58489.12266316009, 58515.414845850995, 61244.69377653083, 62072.37927620666, 63954.0, 63970.202234831646, 64215.6789216051, 12403.317817520123, 12410.069244806675, 12468.75062498745, 12494.687632809071, 12556.560520381743, 11206.775864482664, 11312.490937907814, 11324.886751132548, 11355.148363872577, 11368.886311136948, 18863.151158197914, 18935.242590296508, 19068.523286917938, 19119.235230590897, 19660.50848728793, 7404.666789994355, 7611.543307401574, 7638.350740187036, 7777.5722335270975, 7848.293653571206, 926.4533924984291, 970.9805803884024, 1002.0830939690247, 1016.0296916444778, 1035.2597892506894, 27625.447491050065, 27986.0, 28341.149765507067, 28384.290392740346, 28642.570361444596, 965.3387429610739, 993.9155171810477, 1016.983016983017, 1054.404261592198, 1117.4133579870634, 14572.271386430635, 15018.249087545797, 15111.924440377728, 15355.0, 15366.308516116802, 320208.0, 322395.0, 326848.0, 328002.0, 328321.0, 48276.27585586219, 48839.0, 49226.75386623044, 49264.50735492671, 49529.0, 1215.3012018089635, 1233.444949772606, 1250.118666340228, 1255.4225056474124, 1259.6724851538665, 26752.19743407701, 27793.58309625317, 27836.72163278422, 28217.0, 28319.29201769972, 42114.0, 42443.15113697647, 42473.0, 42877.356839648055, 43028.0, 289426.0, 292642.0, 293882.0, 295034.0, 295116.0, 25583.6162457567, 25863.353416164748, 26079.348016299744, 26165.0, 26365.60451593266, 41699.0, 42385.36421953735, 42540.787296063325, 42657.36013959731, 42762.5723742771, 35653.82173089118, 35776.0, 35794.28411431809, 36123.458148127276, 36451.45322820213, 34100.0, 35889.82055089708, 36670.633293666724, 36943.44584831283, 38427.0, 34313.65686343204, 34596.0, 34604.30791384209, 34796.30407391889, 34901.12747181341, 29522.261943451587, 31613.0, 31653.8417307912, 31680.0, 31722.68277317197, 24438.14466493664, 24467.510649787262, 24834.875825620755, 25179.0, 25221.49557008813], "value": 17250.724187166594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.8731000966998, 381.70608631353844, 387.1965671232193, 393.6240889950098, 400.9057871400222, 15965.521034368972, 17116.315347386106, 17134.31462741489, 17298.394556190506, 17380.826191738095, 15685.686286274296, 16477.83522164778, 16618.58453538659, 16621.83378166218, 16655.91672041641, 3690.5940346561856, 4801.423829140499, 5090.669106508084, 5118.846434606968, 5126.051680439112, 5529.917051244234, 5873.471387575118, 5887.087501437262, 5905.055191169414, 5905.704714764266, 5647.548196144319, 5836.941630583682, 5853.414658534134, 5858.443447872467, 5928.170056192136, 5884.911726324109, 5909.6158749681135, 5915.349311575723, 5919.141724449953, 5928.7628494860155, 5142.948570514322, 5173.586113110942, 5203.375594928595, 5288.048151332759, 5301.443348448434, 20834.27080052191, 20854.47863803402, 21062.157513699585, 21330.0, 21353.252636157817, 1820.9089545522804, 1853.8146185381488, 1931.748872646547, 2201.0, 2247.898844551999, 12688.238705677597, 13007.479700811957, 13062.608121756362, 13065.412056457482, 13476.25880576568, 1621.9107949062798, 1658.4858693804958, 1666.758320043587, 1719.7076496995417, 1728.0754796184108, 68922.31077689209, 70924.29075709281, 71132.0, 71614.28385716128, 71771.0, 9407.482588457564, 9651.179649729711, 9825.606975721033, 9905.752356191153, 10045.296829221885, 13449.798253026212, 13523.59429217125, 13638.454461821615, 13690.863091369158, 13717.588472345846, 7269.273072692688, 7339.77980660581, 7494.625268736541, 7509.399248060142, 7538.057742782153, 7331.816704582428, 7408.85182296351, 7419.925800741924, 7626.161122276545, 7658.4639075264195, 5490.917636235459, 6048.243969503812, 6058.21243238385, 6273.905891411632, 6289.119523266746, 1727.689015977111, 1734.6097128146066, 1789.91945362459, 1790.2123065851245, 1815.8184181581737, 895.6596493332622, 901.454619954931, 928.2573940847295, 947.2611363136764, 1016.761061150629, 16171.595710107342, 16199.514014579581, 16221.945573537681, 16369.544568314848, 16637.750433743502, 936.489613160829, 949.8554242138207, 961.5144352102144, 974.5565767575736, 982.474376208725, 9854.359466634645, 9921.206303495703, 9944.10503054714, 10015.39907605546, 10087.0, 398678.0, 401357.0, 409152.0, 411081.0, 414196.0, 68205.65897170482, 69836.30163698299, 71355.0, 71633.2836671637, 72601.6369918147, 985.980280394388, 993.761497240657, 1003.0922015575916, 1009.2531526670211, 1017.9083882450615, 15017.624559386102, 15087.170205638795, 15103.54689359321, 15392.153431561372, 15703.371865125268, 31669.524957126123, 32058.19854503656, 32413.51379729353, 33680.508858703965, 34523.4821477673, 43011.3548296782, 43837.78081109574, 44408.55591444044, 44786.104277914914, 45207.32189017233, 7591.43064270193, 7655.88516172269, 7667.923320766721, 7860.371170306476, 7888.526688398714, 8280.0, 11128.0, 11327.830082548604, 11711.88288117142, 11869.5845645402, 7898.775689768095, 8929.642814287616, 9990.450525221182, 10174.186065114922, 10398.27212095146, 9462.810743785223, 10303.072723454925, 10464.372137671764, 10750.677479675622, 10786.083182929226, 10133.493325333851, 10644.680659580225, 10816.405097719386, 11011.119110471303, 11075.280106793032, 7693.346065584488, 7736.690532378641, 7737.729179478692, 7906.841863162589, 7945.682172713258, 10603.94698026505, 10698.89301106979, 10774.407407592658, 10837.403942782907, 10878.728031798952], "value": 8411.003768865876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.0659974316566, 1481.1039321210667, 1592.808862936448, 1761.867859910507, 1797.7662903822502, 6984.406325462329, 7733.265339792711, 7810.17993110723, 8089.716859909897, 8118.147594502573, 7688.231176882309, 7712.498687585303, 7769.223077692242, 7769.417293702967, 7823.374130069595, 2232.653938639505, 2272.8409011369213, 2273.4202778291597, 2280.1905323610126, 2285.919992800252, 2190.715207023085, 2237.641977283635, 2276.590213761522, 2277.339571524256, 2280.2589158523465, 2253.267688001398, 2271.114265436473, 2283.292179424384, 2296.9540609187807, 2298.3564601911407, 2165.9133634654595, 2182.334388011656, 2182.596219699353, 2185.1041073160086, 2189.8686078835162, 2199.439143018536, 2200.4938864061355, 2208.8785116818567, 2227.242737469252, 2227.9554408911895, 7943.64253608589, 7979.082405523323, 8000.079990801074, 8000.319972802319, 8041.396895232822, 4667.15991121598, 4764.190087685067, 4809.470958194595, 4819.783109760069, 4825.613950883921, 2925.2979284971666, 2996.8801247950055, 2999.355138645202, 3027.197792584967, 3038.437888990544, 907.1155623267327, 918.4994178172911, 922.5654107862272, 923.6813299411692, 951.8810148731409, 10552.0, 10641.201909856793, 10663.520141593646, 10673.0, 10693.091087257593, 4198.9370159447635, 4235.724677895927, 4341.0, 4439.62263207631, 4450.532694067141, 9174.908250917406, 9175.265978721687, 9181.77045573866, 9185.494797786187, 9204.033576474507, 4811.735354555533, 4813.7593120343845, 4821.445533763592, 4821.614270858323, 4860.149473842134, 3752.0432289765936, 4218.0, 4300.483941926988, 4362.040351122748, 4366.912661746747, 3585.282943411276, 3592.3892938200047, 3652.1782598915033, 3700.6669399753614, 3709.146896213886, 1221.194011952125, 1224.2470880408484, 1249.0507214517033, 1252.2173641474078, 1260.5021016698354, 841.936854735885, 845.7082306604211, 853.3514528958036, 861.2119910282022, 870.508162887979, 5232.0, 5233.764480598382, 5239.423663397023, 5302.681839089667, 5305.62860599762, 419.6915267278548, 424.4249042547366, 424.83006797281337, 425.6892468498014, 428.79846472158033, 3510.57873055235, 3614.7469677122876, 3618.909527261787, 3620.6922411594783, 3667.4132138857653, 9339.486328252011, 9699.757506062264, 9754.512274386252, 9856.605735770489, 9863.852042219372, 9639.277054220962, 9649.517524123767, 9716.708498745049, 9727.270454715925, 9738.659146929824, 7134.928650713427, 7371.631418429057, 7372.336489715952, 7423.591702456417, 7454.434568740625, 5254.0, 5423.29497165366, 5442.265294185393, 5465.344158700981, 5682.516986056232, 8929.73210803677, 8949.418287811272, 9102.453852768855, 9105.27157827359, 9109.271258299452, 9020.188183063556, 9095.49974751395, 9132.178103970675, 9183.494907780136, 9263.444193348421, 6152.354002829818, 6669.333066693292, 6749.831254218684, 6865.347791959756, 6885.793426197222, 7641.694332226649, 7725.381969442544, 7728.536287822523, 7773.572453515111, 7809.960950195213, 6872.140982377203, 7077.964610177122, 7095.0, 7116.573005619679, 7141.535800172972, 6957.2694867038235, 6958.686859091252, 6967.163940327193, 7033.507654464139, 7037.190723066708, 6576.671166441754, 6576.934230657632, 6639.302873198245, 6653.634050127096, 6679.131712877295, 4497.662675299301, 4517.616002639812, 4611.746353950565, 4702.341672165968, 4706.905861882811, 4494.438195225597, 4517.954820451753, 4535.4103966484145, 4558.0, 4562.087582483583], "value": 4145.230933650354, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.55968006869944, 312.62016649770527, 319.7969289501166, 320.8892931938482, 322.098125249302, 5092.974535127329, 5216.765245563949, 5227.137522308819, 5239.633225674204, 5274.551663108636, 5265.447128051557, 5272.657277276974, 5282.366116066068, 5292.417834038252, 5321.4412486688825, 4116.464859568267, 4118.711690181688, 4122.0, 4122.42286079949, 4126.834926602933, 3866.883993480186, 4092.406601042847, 4134.545200027995, 4146.792660366985, 4147.419361289422, 4005.698148101864, 4038.3740520219267, 4040.111175541391, 4040.636342729154, 4049.311617025113, 3996.4005399190064, 4037.454943582608, 4039.919201615966, 4041.737287076345, 4067.4102255172834, 3498.6676265754713, 3503.7372197085065, 3518.700910422617, 3524.0793767396576, 3539.699125574329, 4802.615790736768, 5025.271335656346, 5062.670926389773, 5085.338905942241, 5095.006473737622, 4625.098105869357, 4648.372469716579, 4653.906921861578, 4663.650226233012, 4663.813447462097, 5571.4150014248735, 5588.8423040982125, 5591.580631452657, 5595.153599312258, 5602.495775380195, 3785.470034195215, 3855.20968201518, 3863.497745293094, 3868.941965870514, 3870.1292209252974, 5742.913856292159, 5785.623934444247, 5803.172000819771, 5839.5036421904615, 5839.9124013139835, 3908.355121404936, 3909.5308562972627, 3927.410888366711, 3936.3505021671103, 3937.783421911822, 3793.6585707285926, 3966.682665386762, 3977.7016723745833, 3982.844974957288, 3991.261616600938, 4587.678862479661, 4604.608608268268, 4609.5799705154395, 4618.630509559294, 4624.861254162381, 5238.319018527567, 5497.285352904097, 5511.614187006871, 5534.418886016991, 5550.0, 1346.118292518402, 1380.7100508893045, 1384.0, 1386.0713322074234, 1394.1704685711986, 913.2191975860676, 920.5121285718579, 934.5887809363858, 941.5480569326761, 951.3911096897991, 4815.711057336501, 4817.9518204817505, 4821.63837712173, 4827.131116399082, 4833.3958255218095, 5682.914756278659, 5696.943030569724, 5702.657840529581, 5702.857428564319, 5708.286464191976, 4715.41057367829, 4798.808047678123, 4813.4945830687275, 4820.156472617278, 4823.866391398019, 3057.357954829466, 3071.2475443516037, 3072.55447960049, 3077.2306923269184, 3088.6911308869385, 5319.468053194727, 5329.866753331198, 5337.572994160458, 5378.2470454136455, 5395.676259424447, 5659.179418984224, 5802.912956305659, 5810.94189058104, 5833.300003999547, 5850.64896106235, 5314.202869569595, 5332.893342133136, 5342.572594192456, 5359.598030147755, 5371.731413429235, 5438.721900353493, 5625.606207565431, 5649.802256920988, 5688.687122208318, 5699.5725320600295, 5476.479734425223, 5519.475649813261, 5545.889082218414, 5556.972215138899, 5572.0, 5238.214267859851, 5280.683159010472, 5304.552041173269, 5307.708076055699, 5316.192494551871, 3725.8323375447626, 3900.219956008753, 3911.1395492991496, 3918.568957414739, 3921.7843018633107, 5498.395176530658, 5534.280543529316, 5695.373508913934, 5699.173619825019, 5727.799527016535, 5554.666719996813, 5559.444055594408, 5576.832695018994, 5595.692236926845, 5597.188407680945, 5570.192322113352, 5572.108462645957, 5576.9163462547285, 5590.608657393944, 5603.8879222416135, 5237.502437268454, 5488.451154884479, 5571.387147413862, 5574.498295153456, 5577.912307100077, 5630.3525094613005, 5670.432956704297, 5672.43275672446, 5676.574256930664, 5707.0, 5267.473252674702, 5513.228148059195, 5549.916751248816, 5579.916301255404, 5590.720463976866], "value": 4135.716738576799, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.7740639105073, 752.2665401233797, 754.6302311867183, 761.9657115429806, 772.5905270206792, 11119.166062545311, 11129.610463633775, 11181.776364472726, 11238.66284011479, 11279.661610151688, 11094.334339939589, 11098.944505277463, 11148.554057837697, 11154.330740155596, 11205.439728013607, 612.6416046612726, 773.350385676032, 789.1043665439738, 791.7387262203488, 797.5214871077366, 781.6677911887454, 786.4416264452245, 789.3054112381096, 789.6130895861015, 789.7235967411417, 839.0895877972407, 840.2353857989231, 843.784834867108, 844.7212419901449, 845.4800297816829, 831.6507067031861, 833.5332213960171, 834.0658462521984, 834.9958250208771, 835.419383528448, 612.9478994285491, 614.0788816774838, 614.5605891787393, 615.1510914937403, 616.8303716477959, 11362.48868800906, 11408.0, 11442.885571144265, 11445.656630301104, 11503.367314797682, 11760.70598235051, 11874.821877671842, 12041.217320874202, 12209.267443953391, 12524.123311368208, 9624.855627165598, 9751.3661611995, 9792.363496372784, 9835.606575737034, 9898.10917017472, 2969.346743716379, 2975.895843645462, 2992.7156920092557, 3039.240189952512, 3043.893463728759, 47680.28479572809, 48370.758146209395, 49001.26498102531, 49543.75228123836, 49602.50397496015, 9652.662156824477, 9656.034396560288, 9757.16083264807, 9811.607535698493, 10004.799904001879, 16931.746023809654, 16976.320947161974, 17130.657386852192, 17136.314547418213, 17175.227114779864, 6150.04674275488, 6198.876022479525, 6210.4410603045035, 6228.532860035425, 6323.083152942798, 3373.5614370131725, 3402.591688997287, 3431.8455669494933, 3480.8259587021053, 3816.0, 2707.0660622085347, 2780.666320041608, 2786.275568352243, 2786.3312804926672, 2792.748652621274, 476.91177132229956, 479.1367618670453, 484.9854504364875, 490.76933841094626, 492.36730800920645, 546.0164496094902, 606.2815563557199, 615.5045188623201, 627.1721327847289, 647.733923204355, 7921.603919804102, 8002.839943201104, 8037.276645101969, 8242.381821363422, 8365.539895305696, 520.7136075158647, 557.7211394302849, 607.5716619783042, 608.2305883057935, 619.0837560410617, 3921.705872059607, 3941.9802900985887, 3968.980155099206, 4103.753774773523, 4284.400183974246, 49352.50647493551, 49355.0, 49408.25887611689, 49796.0, 52437.213441798405, 45402.09195816065, 45753.0, 46358.0, 46635.53364466312, 47671.28493072607, 41930.161396772506, 42244.0, 42852.0, 43016.139677206906, 44143.55856441394, 8174.7956301092945, 8292.751217463485, 8394.202550757669, 8534.23191912706, 8591.0, 26971.730282697707, 27191.86404067967, 27237.0, 28280.71719282863, 28432.715672843005, 37001.444978324806, 39424.40863387109, 39698.80150599228, 39707.0, 40033.399499006955, 10535.947320263349, 10540.420276884844, 10560.313579617301, 10622.097121744739, 10726.946365268124, 11878.109141814226, 12207.938960305142, 12346.567870124503, 12400.689982750142, 12463.252204867737, 10548.103411210133, 10649.787004260026, 10693.14454843595, 11094.0, 11197.328160310408, 9877.555510001923, 10058.497075146068, 10133.594656213669, 10159.390436573829, 10274.691759247235, 10626.203034772578, 10662.253642244968, 10681.89318106809, 10794.298370605886, 10806.135509159405, 9195.954020229856, 9222.723318300461, 9509.809803804024, 9565.378250413702, 9809.656662016796, 9533.427994320364, 9769.364991275545, 9783.119519243302, 9857.901420985985, 9903.702888913343], "value": 5822.349815843707, "unit": "score"}], "name": "dromaeo_css", "value": 6377.259223174099, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 113.0, 113.0, 126.0, 116.0, 116.0, 117.0, 112.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 158.0, 200.0, 133.0, 164.0, 165.0, 136.0, 190.0, 134.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 163.0, 174.0, 164.0, 163.0, 163.0, 164.0, 165.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 75.0, 160.0, 80.0, 74.0, 74.0, 77.0, 155.0, 77.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 98.0, 146.0, 94.0, 96.0, 93.0, 141.0, 94.0, 94.0, 136.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 121.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 148.0, 147.0, 149.0, 147.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 66.0, 64.0, 67.0, 78.0, 63.0, 64.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 67.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 79.0, 80.0, 81.0, 81.0, 81.0, 82.0, 88.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 141.0, 134.0, 133.0, 147.0, 145.0, 135.0, 166.0, 136.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 177.0, 179.0, 178.0, 184.0, 177.0, 182.0, 182.0, 176.0, 174.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 76.0, 72.0, 72.0, 75.0, 72.0, 72.0, 73.0, 73.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1604.1, "alertThreshold": 2.0}]} 22:31:01 INFO - Return code: 0 22:31:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:31:02 ERROR - # TBPL SUCCESS # 22:31:02 INFO - Running post-action listener: _resource_record_post_action 22:31:02 INFO - Running post-run listener: _resource_record_post_run 22:31:03 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527159296; Read time: 12; Write time: 1039632 22:31:03 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 233951232; Read time: 0; Write time: 599876 22:31:03 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293208064; Read time: 12; Write time: 439756 22:31:03 INFO - Running post-run listener: _upload_blobber_files 22:31:03 INFO - Blob upload gear active. 22:31:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:31:03 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 22:31:03 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:31:03 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:31:03 INFO - (blobuploader) - INFO - Open directory for files ... 22:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:04 INFO - (blobuploader) - INFO - Done attempting. 22:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:05 INFO - (blobuploader) - INFO - Done attempting. 22:31:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:31:05 INFO - Return code: 0 22:31:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:31:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:31:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cb8b20c23089e9951dccc52f43b71ee05733b02bc442284343bb97a13e6b2fe961cdc68707cb050d456f48d4a35c810eecc91a3d29c0286e6064d80f713a74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdde09c8bafcd95ffd38252a21d557ebc0c96d8b9201f4469dfd298350c612f127c4e3bcc4bfbaabe630ee0b28dfde295146ef29285f7a35e1fdc19c41e065ab"} 22:31:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:31:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:31:05 INFO - Contents: 22:31:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cb8b20c23089e9951dccc52f43b71ee05733b02bc442284343bb97a13e6b2fe961cdc68707cb050d456f48d4a35c810eecc91a3d29c0286e6064d80f713a74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdde09c8bafcd95ffd38252a21d557ebc0c96d8b9201f4469dfd298350c612f127c4e3bcc4bfbaabe630ee0b28dfde295146ef29285f7a35e1fdc19c41e065ab"} 22:31:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:31:05 INFO - Copying logs to upload dir... 22:31:05 INFO - mkdir: /builds/slave/test/build/upload/logs 22:31:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.367905 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-18 22:31:05.120919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 22:31:05.124733) ========= 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=df17445c3590ff7897617a0e00000225-1461040802.438243-614595192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cb8b20c23089e9951dccc52f43b71ee05733b02bc442284343bb97a13e6b2fe961cdc68707cb050d456f48d4a35c810eecc91a3d29c0286e6064d80f713a74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdde09c8bafcd95ffd38252a21d557ebc0c96d8b9201f4469dfd298350c612f127c4e3bcc4bfbaabe630ee0b28dfde295146ef29285f7a35e1fdc19c41e065ab"} build_url:https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/SgxbkAsBTd2D8cnBwXFn9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1cb8b20c23089e9951dccc52f43b71ee05733b02bc442284343bb97a13e6b2fe961cdc68707cb050d456f48d4a35c810eecc91a3d29c0286e6064d80f713a74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdde09c8bafcd95ffd38252a21d557ebc0c96d8b9201f4469dfd298350c612f127c4e3bcc4bfbaabe630ee0b28dfde295146ef29285f7a35e1fdc19c41e065ab"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 22:31:05.153527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:31:05.153889) ========= 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=df17445c3590ff7897617a0e00000225-1461040802.438243-614595192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 22:31:05.233855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 22:31:05.237206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 22:31:05.237500) ========= ========= Total master_lag: 0.29 =========