builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1461242595.64 results: success (0) buildid: 20160421030302 builduid: 62df28e9dc7844a8ac14ab1989f96774 revision: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.642203) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.642680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.642981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.660979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.661278) ========= 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=6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 05:43:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.1M=0.001s 2016-04-21 05:43:16 (12.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.822001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.822352) ========= 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=6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016600 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:15.871916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 05:43:15.872311) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e3ad95d689a5beabf3c1f41d958794fe00e3767 --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 4e3ad95d689a5beabf3c1f41d958794fe00e3767 --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=6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 05:43:16,226 truncating revision to first 12 chars 2016-04-21 05:43:16,226 Setting DEBUG logging. 2016-04-21 05:43:16,226 attempt 1/10 2016-04-21 05:43:16,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e3ad95d689a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 05:43:17,378 unpacking tar archive at: mozilla-central-4e3ad95d689a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.442906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 05:43:17.328320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:17.328648) ========= script_repo_revision: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:17.329052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:17.329334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:43:17.336804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-21 05:43:17.337173) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:17 INFO - MultiFileLogger online at 20160421 05:43:17 in /builds/slave/test 05:43:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:43:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:43:17 INFO - {'append_to_log': False, 05:43:17 INFO - 'base_work_dir': '/builds/slave/test', 05:43:17 INFO - 'blob_upload_branch': 'Firefox', 05:43:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:43:17 INFO - 'branch': 'Firefox', 05:43:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:17 INFO - 'config_files': ('talos/linux_config.py',), 05:43:17 INFO - 'default_actions': ('clobber', 05:43:17 INFO - 'read-buildbot-config', 05:43:17 INFO - 'download-and-extract', 05:43:17 INFO - 'populate-webroot', 05:43:17 INFO - 'create-virtualenv', 05:43:17 INFO - 'install', 05:43:17 INFO - 'run-tests'), 05:43:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:17 INFO - 'download_minidump_stackwalk': True, 05:43:17 INFO - 'download_symbols': 'ondemand', 05:43:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:17 INFO - 'installer_path': 'installer.exe', 05:43:17 INFO - 'log_level': 'info', 05:43:17 INFO - 'log_name': 'talos', 05:43:17 INFO - 'log_to_console': True, 05:43:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:17 INFO - 'opt_config_files': (), 05:43:17 INFO - 'pip_index': False, 05:43:17 INFO - 'sps_profile': False, 05:43:17 INFO - 'sps_profile_interval': 0, 05:43:17 INFO - 'suite': 'dromaeojs-e10s', 05:43:17 INFO - 'system_bits': '32', 05:43:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:17 INFO - 'title': 'talos-linux64-ix-050', 05:43:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:17 INFO - 'use_talos_json': True, 05:43:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:43:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:17 INFO - 'work_dir': 'build'} 05:43:17 INFO - ##### 05:43:17 INFO - ##### Running clobber step. 05:43:17 INFO - ##### 05:43:17 INFO - Running pre-action listener: _resource_record_pre_action 05:43:17 INFO - Running main action method: clobber 05:43:17 INFO - rmtree: /builds/slave/test/build 05:43:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:43:18 INFO - Running post-action listener: _resource_record_post_action 05:43:18 INFO - ##### 05:43:18 INFO - ##### Running read-buildbot-config step. 05:43:18 INFO - ##### 05:43:18 INFO - Running pre-action listener: _resource_record_pre_action 05:43:18 INFO - Running main action method: read_buildbot_config 05:43:18 INFO - Using buildbot properties: 05:43:18 INFO - { 05:43:18 INFO - "project": "", 05:43:18 INFO - "product": "firefox", 05:43:18 INFO - "script_repo_revision": "production", 05:43:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:43:18 INFO - "repository": "", 05:43:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:43:18 INFO - "buildid": "20160421030302", 05:43:18 INFO - "stage_platform": "linux64-pgo", 05:43:18 INFO - "basedir": "/builds/slave/test", 05:43:18 INFO - "nightly_build": "True", 05:43:18 INFO - "buildnumber": 710, 05:43:18 INFO - "slavename": "talos-linux64-ix-050", 05:43:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:43:18 INFO - "platform": "ubuntu64_hw", 05:43:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:18 INFO - "branch": "mozilla-central", 05:43:18 INFO - "repo_path": "mozilla-central", 05:43:18 INFO - "revision": "4e3ad95d689a5beabf3c1f41d958794fe00e3767", 05:43:18 INFO - "pgo_build": "True", 05:43:18 INFO - "builduid": "62df28e9dc7844a8ac14ab1989f96774", 05:43:18 INFO - "slavebuilddir": "test" 05:43:18 INFO - } 05:43:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:43:18 INFO - Running post-action listener: _resource_record_post_action 05:43:18 INFO - ##### 05:43:18 INFO - ##### Running download-and-extract step. 05:43:18 INFO - ##### 05:43:18 INFO - Running pre-action listener: _resource_record_pre_action 05:43:18 INFO - Running main action method: download_and_extract 05:43:18 INFO - mkdir: /builds/slave/test/build/tests 05:43: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')]} 05:43:18 INFO - https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:23 INFO - Downloaded 1361 bytes. 05:43:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:43:23 INFO - Using the following test package requirements: 05:43:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:43:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'jsshell-linux-x86_64.zip'], 05:43:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:23 INFO - https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:32 INFO - Downloaded 23847181 bytes. 05:43:32 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'] 05:43:32 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 05:43:34 INFO - Return code: 0 05:43:34 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 05:43: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')]} 05:43:34 INFO - https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:35 INFO - Downloaded 23847181 bytes. 05:43:35 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'] 05:43:35 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 05:43:36 INFO - Return code: 0 05:43: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')]} 05:43:36 INFO - https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:37 INFO - Downloaded 10845952 bytes. 05:43:37 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'] 05:43:37 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 05:43:37 INFO - Return code: 0 05:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:37 INFO - https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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 05:43:39 INFO - Downloaded 58342983 bytes. 05:43:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:39 INFO - mkdir: /builds/slave/test/properties 05:43:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:39 INFO - Contents: 05:43:39 INFO - build_url:https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:40 INFO - Running post-action listener: _resource_record_post_action 05:43:40 INFO - Running post-action listener: set_extra_try_arguments 05:43:40 INFO - ##### 05:43:40 INFO - ##### Running populate-webroot step. 05:43:40 INFO - ##### 05:43:40 INFO - Running pre-action listener: _resource_record_pre_action 05:43:40 INFO - Running main action method: populate_webroot 05:43:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:40 INFO - '--tppagecycles', 05:43:40 INFO - '7'], 05:43:40 INFO - 'tests': ['tsvgm']}}, 05:43:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['damp', 'tps']}, 05:43:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['damp', 'tps']}, 05:43:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['dromaeo_dom']}, 05:43:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore', 05:43:40 INFO - 'tabpaint']}, 05:43:40 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore', 05:43:40 INFO - 'tabpaint']}, 05:43:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore', 05:43:40 INFO - 'tabpaint']}, 05:43:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore', 05:43:40 INFO - 'tabpaint']}, 05:43:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore', 05:43:40 INFO - 'tabpaint']}, 05:43:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore', 05:43:40 INFO - 'tabpaint']}, 05:43:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['tsvgx', 05:43:40 INFO - 'tsvgr_opacity', 05:43:40 INFO - 'tart', 05:43:40 INFO - 'tscrollx', 05:43:40 INFO - 'cart']}, 05:43:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:40 INFO - 'tsvgr_opacity', 05:43:40 INFO - 'tart', 05:43:40 INFO - 'tscrollx', 05:43:40 INFO - 'cart']}, 05:43:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--disable-e10s'], 05:43:40 INFO - 'tests': ['tp5o']}, 05:43:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['tp5o']}, 05:43:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--disable-e10s', 05:43:40 INFO - '--xperf_path', 05:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:40 INFO - 'tests': ['tp5n']}, 05:43:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--xperf_path', 05:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:40 INFO - 'tests': ['tp5n']}}, 05:43:40 INFO - 'talos.zip': {'path': '', 05:43:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:40 INFO - Running post-action listener: _resource_record_post_action 05:43:40 INFO - ##### 05:43:40 INFO - ##### Running create-virtualenv step. 05:43:40 INFO - ##### 05:43:40 INFO - Running pre-action listener: _resource_record_pre_action 05:43:40 INFO - Running main action method: create_virtualenv 05:43:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:40 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 05:43:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:43:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:40 INFO - Using real prefix '/usr' 05:43:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:43 INFO - Installing pip.................done. 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43:43 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 05:43:43 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 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:43 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 05:43:43 INFO - Cleaning up... 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43:43 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 05:43:43 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 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:43 INFO - Downloading/unpacking psutil>=0.7.1 05:43:43 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 05:43:43 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 05:43:43 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 05:43:43 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 05:43:43 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 05:43:43 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 05:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:45 INFO - Installing collected packages: psutil 05:43:45 INFO - Running setup.py install for psutil 05:43:45 INFO - building 'psutil._psutil_linux' extension 05:43:45 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 05:43:45 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 05:43:45 INFO - building 'psutil._psutil_posix' extension 05:43:45 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 05:43:45 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 05:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:46 INFO - Successfully installed psutil 05:43:46 INFO - Cleaning up... 05:43:46 INFO - Return code: 0 05:43:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', '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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:43: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 mozsystemmonitor==0.0.0 05:43:46 INFO - Using env: {'DISPLAY': ':0', 05:43:46 INFO - 'HOME': '/home/cltbld', 05:43:46 INFO - 'LANG': 'en_US.UTF-8', 05:43:46 INFO - 'LANGUAGE': 'en_US:en', 05:43:46 INFO - 'LOGNAME': 'cltbld', 05:43:46 INFO - 'MAIL': '/var/mail/cltbld', 05:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:46 INFO - 'MOZ_NO_REMOTE': '1', 05:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:46 INFO - 'NO_EM_RESTART': '1', 05:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:46 INFO - 'PWD': '/builds/slave/test', 05:43:46 INFO - 'SHELL': '/bin/bash', 05:43:46 INFO - 'SHLVL': '1', 05:43:46 INFO - 'TERM': 'linux', 05:43:46 INFO - 'TMOUT': '86400', 05:43:46 INFO - 'USER': 'cltbld', 05:43:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:46 INFO - '_': '/tools/buildbot/bin/python'} 05:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:43:48 INFO - Installing collected packages: mozsystemmonitor 05:43:48 INFO - Running setup.py install for mozsystemmonitor 05:43:48 INFO - Successfully installed mozsystemmonitor 05:43:48 INFO - Cleaning up... 05:43:48 INFO - Return code: 0 05:43:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:48 INFO - Using env: {'DISPLAY': ':0', 05:43:48 INFO - 'HOME': '/home/cltbld', 05:43:48 INFO - 'LANG': 'en_US.UTF-8', 05:43:48 INFO - 'LANGUAGE': 'en_US:en', 05:43:48 INFO - 'LOGNAME': 'cltbld', 05:43:48 INFO - 'MAIL': '/var/mail/cltbld', 05:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:48 INFO - 'MOZ_NO_REMOTE': '1', 05:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:48 INFO - 'NO_EM_RESTART': '1', 05:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:48 INFO - 'PWD': '/builds/slave/test', 05:43:48 INFO - 'SHELL': '/bin/bash', 05:43:48 INFO - 'SHLVL': '1', 05:43:48 INFO - 'TERM': 'linux', 05:43:48 INFO - 'TMOUT': '86400', 05:43:48 INFO - 'USER': 'cltbld', 05:43:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:48 INFO - '_': '/tools/buildbot/bin/python'} 05:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:50 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 05:43:50 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 05:43:50 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 05:43:50 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 05:43:50 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 05:43:50 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 05:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:50 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 05:43:50 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 05:43:50 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 05:43:50 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 05:43:50 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 05:43:50 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 05:43:51 INFO - Downloading docopt-0.6.1.tar.gz 05:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:51 INFO - Running setup.py install for blobuploader 05:43:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:51 INFO - Running setup.py install for requests 05:43:51 INFO - Running setup.py install for docopt 05:43:51 INFO - Successfully installed blobuploader requests docopt 05:43:51 INFO - Cleaning up... 05:43:51 INFO - Return code: 0 05:43:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43:51 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 05:43:51 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 05:43:51 INFO - Using env: {'DISPLAY': ':0', 05:43:51 INFO - 'HOME': '/home/cltbld', 05:43:51 INFO - 'LANG': 'en_US.UTF-8', 05:43:51 INFO - 'LANGUAGE': 'en_US:en', 05:43:51 INFO - 'LOGNAME': 'cltbld', 05:43:51 INFO - 'MAIL': '/var/mail/cltbld', 05:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:51 INFO - 'MOZ_NO_REMOTE': '1', 05:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:51 INFO - 'NO_EM_RESTART': '1', 05:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:51 INFO - 'PWD': '/builds/slave/test', 05:43:51 INFO - 'SHELL': '/bin/bash', 05:43:51 INFO - 'SHLVL': '1', 05:43:51 INFO - 'TERM': 'linux', 05:43:51 INFO - 'TMOUT': '86400', 05:43:51 INFO - 'USER': 'cltbld', 05:43:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:51 INFO - '_': '/tools/buildbot/bin/python'} 05:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:52 INFO - Running setup.py (path:/tmp/pip-IpOPxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:52 INFO - Running setup.py (path:/tmp/pip-07QEfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:52 INFO - Running setup.py (path:/tmp/pip-1rbiRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:52 INFO - Running setup.py (path:/tmp/pip-6DW7it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:52 INFO - Running setup.py (path:/tmp/pip-Hn7a_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:52 INFO - Running setup.py (path:/tmp/pip-LddQmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:52 INFO - Running setup.py (path:/tmp/pip-5BgY5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:52 INFO - Running setup.py (path:/tmp/pip-LoB0Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:52 INFO - Running setup.py (path:/tmp/pip-r8DnfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:52 INFO - Running setup.py (path:/tmp/pip-HxLp3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:52 INFO - Running setup.py (path:/tmp/pip-ejb9rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:52 INFO - Running setup.py (path:/tmp/pip-3CUCL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:52 INFO - Running setup.py (path:/tmp/pip-G4TWBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:52 INFO - Running setup.py (path:/tmp/pip-gzQkYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:53 INFO - Running setup.py (path:/tmp/pip-w_DauV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:53 INFO - Running setup.py (path:/tmp/pip-FhC0wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:53 INFO - Running setup.py (path:/tmp/pip-PJMSug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:53 INFO - Running setup.py install for manifestparser 05:43:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:53 INFO - Running setup.py install for mozcrash 05:43:53 INFO - Running setup.py install for mozdebug 05:43:53 INFO - Running setup.py install for mozdevice 05:43:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:43:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:53 INFO - Running setup.py install for mozfile 05:43:53 INFO - Running setup.py install for mozhttpd 05:43:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:53 INFO - Running setup.py install for mozinfo 05:43:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:53 INFO - Running setup.py install for mozInstall 05:43:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Running setup.py install for mozleak 05:43:54 INFO - Running setup.py install for mozlog 05:43:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Running setup.py install for moznetwork 05:43:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Running setup.py install for mozprocess 05:43:54 INFO - Running setup.py install for mozprofile 05:43:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Running setup.py install for mozrunner 05:43:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:54 INFO - Running setup.py install for mozscreenshot 05:43:54 INFO - Running setup.py install for moztest 05:43:54 INFO - Running setup.py install for mozversion 05:43:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:55 INFO - Cleaning up... 05:43:55 INFO - Return code: 0 05:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43:55 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 05:43:55 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 05:43:55 INFO - Using env: {'DISPLAY': ':0', 05:43:55 INFO - 'HOME': '/home/cltbld', 05:43:55 INFO - 'LANG': 'en_US.UTF-8', 05:43:55 INFO - 'LANGUAGE': 'en_US:en', 05:43:55 INFO - 'LOGNAME': 'cltbld', 05:43:55 INFO - 'MAIL': '/var/mail/cltbld', 05:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:55 INFO - 'MOZ_NO_REMOTE': '1', 05:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:55 INFO - 'NO_EM_RESTART': '1', 05:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:55 INFO - 'PWD': '/builds/slave/test', 05:43:55 INFO - 'SHELL': '/bin/bash', 05:43:55 INFO - 'SHLVL': '1', 05:43:55 INFO - 'TERM': 'linux', 05:43:55 INFO - 'TMOUT': '86400', 05:43:55 INFO - 'USER': 'cltbld', 05:43:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:55 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:55 INFO - Running setup.py (path:/tmp/pip-w8Lr43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:55 INFO - Running setup.py (path:/tmp/pip-ucLXgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:55 INFO - Running setup.py (path:/tmp/pip-knbhmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:55 INFO - Running setup.py (path:/tmp/pip-YR4wNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:55 INFO - Running setup.py (path:/tmp/pip-gKO96h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:55 INFO - Running setup.py (path:/tmp/pip-ZwbxcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:55 INFO - Running setup.py (path:/tmp/pip-8I4WW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:55 INFO - Running setup.py (path:/tmp/pip-ch32Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:55 INFO - Running setup.py (path:/tmp/pip-lFw9je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:55 INFO - Running setup.py (path:/tmp/pip-ljlObT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:55 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)) 05:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:55 INFO - Running setup.py (path:/tmp/pip-ryYyvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:56 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)) 05:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:56 INFO - Running setup.py (path:/tmp/pip-S2uNqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:56 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)) 05:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:56 INFO - Running setup.py (path:/tmp/pip-hCGZYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:56 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)) 05:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:56 INFO - Running setup.py (path:/tmp/pip-Q3xxw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:56 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)) 05:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:56 INFO - Running setup.py (path:/tmp/pip-HExjgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:56 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)) 05:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:56 INFO - Running setup.py (path:/tmp/pip-w2_CcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:56 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)) 05:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:56 INFO - Running setup.py (path:/tmp/pip-hU7JXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:56 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)) 05:43:56 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)) 05:43:56 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)) 05:43:56 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)) 05:43:56 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)) 05:43:56 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)) 05:43:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:58 INFO - Downloading blessings-1.6.tar.gz 05:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:58 INFO - Installing collected packages: blessings 05:43:58 INFO - Running setup.py install for blessings 05:43:58 INFO - Successfully installed blessings 05:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:58 INFO - Reading from file tmpfile_stdout 05:43:58 INFO - Current package versions: 05:43:58 INFO - argparse == 1.2.1 05:43:58 INFO - blessings == 1.6 05:43:58 INFO - blobuploader == 1.2.4 05:43:58 INFO - docopt == 0.6.1 05:43:58 INFO - manifestparser == 1.1 05:43:58 INFO - mozInstall == 1.12 05:43:58 INFO - mozcrash == 0.17 05:43:58 INFO - mozdebug == 0.1 05:43:58 INFO - mozdevice == 0.48 05:43:58 INFO - mozfile == 1.2 05:43:58 INFO - mozhttpd == 0.7 05:43:58 INFO - mozinfo == 0.9 05:43:58 INFO - mozleak == 0.1 05:43:58 INFO - mozlog == 3.1 05:43:58 INFO - moznetwork == 0.27 05:43:58 INFO - mozprocess == 0.22 05:43:58 INFO - mozprofile == 0.28 05:43:58 INFO - mozrunner == 6.11 05:43:58 INFO - mozscreenshot == 0.1 05:43:58 INFO - mozsystemmonitor == 0.0 05:43:58 INFO - moztest == 0.7 05:43:58 INFO - mozversion == 1.4 05:43:58 INFO - psutil == 3.1.1 05:43:58 INFO - requests == 1.2.3 05:43:58 INFO - wsgiref == 0.1.2 05:43:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:58 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')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 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')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43:58 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 05:43:58 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 05:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 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)) 05:43:59 INFO - Cleaning up... 05:43:59 INFO - Return code: 0 05:43:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:43: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', 'jsonschema'] in /builds/slave/test/build 05:43: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 jsonschema 05:43:59 INFO - Using env: {'DISPLAY': ':0', 05:43:59 INFO - 'HOME': '/home/cltbld', 05:43:59 INFO - 'LANG': 'en_US.UTF-8', 05:43:59 INFO - 'LANGUAGE': 'en_US:en', 05:43:59 INFO - 'LOGNAME': 'cltbld', 05:43:59 INFO - 'MAIL': '/var/mail/cltbld', 05:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:59 INFO - 'MOZ_NO_REMOTE': '1', 05:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:59 INFO - 'NO_EM_RESTART': '1', 05:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:59 INFO - 'PWD': '/builds/slave/test', 05:43:59 INFO - 'SHELL': '/bin/bash', 05:43:59 INFO - 'SHLVL': '1', 05:43:59 INFO - 'TERM': 'linux', 05:43:59 INFO - 'TMOUT': '86400', 05:43:59 INFO - 'USER': 'cltbld', 05:43:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:59 INFO - '_': '/tools/buildbot/bin/python'} 05:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:59 INFO - Downloading/unpacking jsonschema 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:44:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:01 INFO - warning: no files found matching '*.txt' 05:44:01 INFO - no previously-included directories found matching 'build' 05:44:01 INFO - no previously-included directories found matching 'dist' 05:44:01 INFO - no previously-included directories found matching '.git*' 05:44:01 INFO - Installing collected packages: jsonschema, functools32 05:44:01 INFO - Running setup.py install for functools32 05:44:01 INFO - warning: no files found matching '*.txt' 05:44:01 INFO - no previously-included directories found matching 'build' 05:44:01 INFO - no previously-included directories found matching 'dist' 05:44:01 INFO - no previously-included directories found matching '.git*' 05:44:01 INFO - Successfully installed jsonschema functools32 05:44:01 INFO - Cleaning up... 05:44:01 INFO - Return code: 0 05:44:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:44:01 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')]} 05:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:01 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')]} 05:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:01 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 0x7fb0f894af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25285a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', '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 05:44:01 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 05:44:01 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 05:44:01 INFO - Using env: {'DISPLAY': ':0', 05:44:01 INFO - 'HOME': '/home/cltbld', 05:44:01 INFO - 'LANG': 'en_US.UTF-8', 05:44:01 INFO - 'LANGUAGE': 'en_US:en', 05:44:01 INFO - 'LOGNAME': 'cltbld', 05:44:01 INFO - 'MAIL': '/var/mail/cltbld', 05:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:01 INFO - 'MOZ_NO_REMOTE': '1', 05:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:01 INFO - 'NO_EM_RESTART': '1', 05:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:01 INFO - 'PWD': '/builds/slave/test', 05:44:01 INFO - 'SHELL': '/bin/bash', 05:44:01 INFO - 'SHLVL': '1', 05:44:01 INFO - 'TERM': 'linux', 05:44:01 INFO - 'TMOUT': '86400', 05:44:01 INFO - 'USER': 'cltbld', 05:44:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:01 INFO - '_': '/tools/buildbot/bin/python'} 05:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:01 INFO - Downloading/unpacking flake8 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:03 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 05:44:03 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 05:44:03 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 05:44:03 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 05:44:03 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 05:44:03 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 05:44:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44:03 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 05:44:03 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 05:44:03 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 05:44:03 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 05:44:03 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 05:44:03 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 05:44:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:04 INFO - no previously-included directories found matching 'docs/_build' 05:44:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:04 INFO - Running setup.py install for pep8 05:44:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:04 INFO - no previously-included directories found matching 'docs/_build' 05:44:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:04 INFO - Cleaning up... 05:44:04 INFO - Return code: 0 05:44:04 INFO - Running post-action listener: _resource_record_post_action 05:44:04 INFO - Running post-action listener: _start_resource_monitoring 05:44:04 INFO - Starting resource monitoring. 05:44:04 INFO - ##### 05:44:04 INFO - ##### Running install step. 05:44:04 INFO - ##### 05:44:04 INFO - Running pre-action listener: _resource_record_pre_action 05:44:04 INFO - Running main action method: install 05:44:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:04 INFO - Reading from file tmpfile_stdout 05:44:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:44:05 INFO - Reading from file tmpfile_stdout 05:44:05 INFO - Output received: 05:44:05 INFO - Usage: mozinstall [options] installer 05:44:05 INFO - Options: 05:44:05 INFO - -h, --help show this help message and exit 05:44:05 INFO - -d DEST, --destination=DEST 05:44:05 INFO - Directory to install application into. [default: 05:44:05 INFO - "/builds/slave/test"] 05:44:05 INFO - --app=APP Application being installed. [default: firefox] 05:44:05 INFO - mkdir: /builds/slave/test/build/application 05:44:05 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'] 05:44:05 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 05:44:21 INFO - Reading from file tmpfile_stdout 05:44:21 INFO - Output received: 05:44:21 INFO - /builds/slave/test/build/application/firefox/firefox 05:44:21 INFO - Running post-action listener: _resource_record_post_action 05:44:21 INFO - ##### 05:44:21 INFO - ##### Running run-tests step. 05:44:21 INFO - ##### 05:44:21 INFO - Running pre-action listener: _resource_record_pre_action 05:44:21 INFO - Running main action method: run_tests 05:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:21 INFO - Python 2.7.3 05:44:21 INFO - Return code: 0 05:44:21 INFO - grabbing minidump binary from tooltool 05:44: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')]} 05:44:21 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 0x25b7410>, '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 0x25b8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:21 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 05:44:21 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 05:44:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:21 INFO - Return code: 0 05:44:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:44:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:44:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:44:22 INFO - Return code: 0 05:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 05:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 05:44:22 INFO - Using env: {'DISPLAY': ':0', 05:44:22 INFO - 'HOME': '/home/cltbld', 05:44:22 INFO - 'LANG': 'en_US.UTF-8', 05:44:22 INFO - 'LANGUAGE': 'en_US:en', 05:44:22 INFO - 'LOGNAME': 'cltbld', 05:44:22 INFO - 'MAIL': '/var/mail/cltbld', 05:44:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:22 INFO - 'MOZ_NO_REMOTE': '1', 05:44:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:22 INFO - 'NO_EM_RESTART': '1', 05:44:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:22 INFO - 'PWD': '/builds/slave/test', 05:44:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:22 INFO - 'SHELL': '/bin/bash', 05:44:22 INFO - 'SHLVL': '1', 05:44:22 INFO - 'TERM': 'linux', 05:44:22 INFO - 'TMOUT': '86400', 05:44:22 INFO - 'USER': 'cltbld', 05:44:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838', 05:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:22 INFO - '_': '/tools/buildbot/bin/python'} 05:44:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 05:44:22 INFO - mozversion application_buildid: 20160421030302 05:44:22 INFO - mozversion application_changeset: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 05:44:22 INFO - mozversion application_display_name: Nightly 05:44:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:22 INFO - mozversion application_name: Firefox 05:44:22 INFO - mozversion application_remotingname: firefox 05:44:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:22 INFO - mozversion application_vendor: Mozilla 05:44:22 INFO - mozversion application_version: 48.0a1 05:44:22 INFO - mozversion platform_buildid: 20160421030302 05:44:22 INFO - mozversion platform_changeset: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 05:44:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:22 INFO - mozversion platform_version: 48.0a1 05:44:22 INFO - using testdate: 1461242662 05:44:22 INFO - actual date: 1461242662 05:44:22 INFO - starting webserver on 'localhost:49400' 05:44:22 INFO - SUITE-START | Running 2 tests 05:44:22 INFO - TEST-START | dromaeo_css 05:44:22 INFO - operating with platform_type : linux_ 05:44:22 INFO - Initialising browser for dromaeo_css test... 05:44:22 INFO - TEST-INFO | started process 10519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDm_fjJ/profile http://localhost:49400/getInfo.html) 05:44:26 INFO - PROCESS | 10519 | 05:44:26 INFO - PROCESS | 10519 | (process:10588): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:27 INFO - PROCESS | 10519 | __metrics Screen width/height:1600/1200 05:44:27 INFO - PROCESS | 10519 | colorDepth:24 05:44:27 INFO - PROCESS | 10519 | Browser inner width/height: 1024/697 05:44:27 INFO - PROCESS | 10519 | __metrics 05:44:27 ERROR - PROCESS | 10519 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:44:28 INFO - TEST-INFO | 10519: exit 0 05:44:28 INFO - Browser initialized. 05:44:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:28 INFO - TEST-INFO | started process 10639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDm_fjJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:30 INFO - PROCESS | 10639 | 05:44:30 INFO - PROCESS | 10639 | (process:10700): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:40 INFO - PROCESS | 10639 | RSS: Main: 163577856 05:44:40 INFO - PROCESS | 10639 | 05:45:29 INFO - PROCESS | 10639 | 1461242729993 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] 05:47:37 INFO - PROCESS | 10639 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49400/tests/dromaeo/cssquery-ext.html) 05:47:38 INFO - PROCESS | 10639 | RSS: Main: 168628224 05:47:38 INFO - PROCESS | 10639 | 05:50:40 INFO - PROCESS | 10639 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-ext.html (next: http://localhost:49400/tests/dromaeo/cssquery-jquery.html) 05:50:41 INFO - PROCESS | 10639 | RSS: Main: 166490112 05:50:41 INFO - PROCESS | 10639 | 05:53:43 INFO - PROCESS | 10639 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49400/tests/dromaeo/cssquery-mootools.html) 05:53:43 INFO - PROCESS | 10639 | RSS: Main: 166543360 05:53:43 INFO - PROCESS | 10639 | 05:56:45 INFO - PROCESS | 10639 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49400/tests/dromaeo/cssquery-prototype.html) 05:56:46 INFO - PROCESS | 10639 | RSS: Main: 164102144 05:56:46 INFO - PROCESS | 10639 | 05:59:48 INFO - PROCESS | 10639 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49400/tests/dromaeo/cssquery-yui.html) 05:59:49 INFO - PROCESS | 10639 | RSS: Main: 165527552 05:59:49 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-yui.html (next: http://localhost:49400/tests/dromaeo/cssquery-dojo.html) 06:02:51 INFO - PROCESS | 10639 | RSS: Main: 167727104 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | __start_tp_report 06:02:51 INFO - PROCESS | 10639 | _x_x_mozilla_page_load 06:02:51 INFO - PROCESS | 10639 | _x_x_mozilla_page_load_details 06:02:51 INFO - PROCESS | 10639 | |i|pagename|runs| 06:02:51 INFO - PROCESS | 10639 | |0;dojo.html;3103.689631036896;3139.544766008929;3199.264169241076;3228;3231.8868839590605;5464.562834973198;5481.4518548145215;5483.150111732688;5483.232347471348;5496.3953965063865;5366.677999320043;5425.2675888755;5473.945260547403;5538.556915446765;5566.972165139168;4861.829835955733;4864.318995340655;4924.901501969976;4943.184374578191;4985.376827896513;906.0334716602529;4855.854324370274;4937.80248790048;4941.604671626261;4999.300097986266;4908.312836202935;4933.629977751665;4934.69230653877;4939.333190019337;4968.602511799066;4796.112719146969;5008.84973450797;5014.84955451337;5022.698638081691;5062.2406639004075;4797.808087676489;4837.346958160673;4845.152098382769;4847.103285892122;4869.951300486985;5355.30381050461;5387.676739395649;5415.702136382497;5425.13197888336;5430.348358197002;5726.0838265877255;5806.883862322772;5853.64878107315;5862.50168735658;5866.853328666817;5787.71061446926;5848.649081055108;5856.795012174596;5857.47282744555;5882.470577648032;5341.67949923002;5423.105187644073;5431.728413579305;5447.727613619343;5449.754761035763;5799.594028418054;5926.199963005025;5967.671778052249;6017.669028203403;6061.060535616986;5690.7439165237665;5782.508486778587;5786.826395208151;5798.362180160179;5812.912806307909;5835.095560188178;5865.120231965154;5868.882622347614;5870.060790273621;5871.207387002785;5577.498025177753;5664.745086471119;5740.225069615632;5747.971260143672;5790.507806836382;5618.297712785902;5781.53747700183;5798.391168927286;5808.506276966421;5856.0630299151935;4393;4429.180601588717;4430.091831174602;4437.889052773707;4485.237509623306;3800.1449673823167;3906.921861562753;3917.0990672145567;3951.328274193394;3973.5430425501436;5574.331080270313;5585.134304182858;5587.413321601254;5589.860253493695;5627.606067575231;5770.682612456355;5805.187273781674;5875.559333049953;5883.294004719461;5889.057750759858;5508.55931525477;5517.089680202802;5531.225628412026;5569.972150139304;5586.888262234733;4980.2778597103215;4983.750812459362;4985.925211121836;5000.474950130257;5038.370203724535;5788;5918.556108291809;5943.049112142036;5952.880942381128;5977.970110149508;5828.329742079715;5864.530837532901;5867.618604790675;5873.471387575139;5890.941090589039;5962.642241465526;6008;6018.3680713524445;6025.1564780931585;6032.487238584769;5623.325200975909;5659;5669.262995810518;5757.165211044459;5760.683162426107;5854;5875.383084776208;5885.61743486672;5887.411258874078;5898.734556945034;5665.603407761417;5705.942940570541;5710;5722.055860782924;5724.542036637143;5428.212909128233;5657.2928383952;5695.572832037531;5741.712914354182;5798.159266906359;5425.511703946664;5513.641613295123;5544.61187716856;5547.029269877675;5606.271184745957;5623.746931388179;5628.437156284339;5628.521575665951;5655.971720141538;5669.234653321749;5562.833115006556;5601.495865372136;5645.68948707825;5646.153077038477;5710.172025056427 06:02:51 INFO - PROCESS | 10639 | |1;ext.html;574.8591595059211;646.9514786391019;659.9670016499175;666.4068978609035;669.1869378704872;34839.12902177447;35869.641303586955;36040.81979590105;36065.81967090164;36193.819030904844;41401.58598414015;41808.581914180846;42094.7895260524;42144.789276053576;42153;8747.081556436578;8940.06129356418;8952.597133128993;8960.955195224047;8964.551772411385;8721.60752766127;8782.604782784758;8806.515641639708;8811.471311721285;8841;8833.381663283573;8887.73336799897;8888.955555222215;8906.73279801607;8921.063288354726;8799.076097009785;8803.691870784523;8831.381803273773;8860.955695221483;8868.689595864145;8774.210321071134;8793.076726943642;8798.252148567315;8849.336299777542;8860.734177974671;30937.535936960965;37168.44247336292;37377.25245495102;37766.03456637068;37778.43332350017;3323.3391976608673;3353.446681297583;3530.188056746937;3709.3879509880835;3906.257811015926;26071.08751193718;26401.3399665008;26425.471490570275;26886.386816791055;27283.727162728515;3996.300647386696;4023.6781057515327;4028.8992775180855;4060.675145988314;4103.589641035903;232013;232061;233430;233823;234118;33206.8339658305;33879.967201967964;34599.4810077849;35251.82374088113;35301.64698353035;35325.646743532234;35573.28853422917;35595.28809423797;35681.46477802835;35686.821565892526;14937.327820248114;15145.318460669296;15180.316885740169;15183.696326073637;15200;12475.812862807064;12524.68688282782;12546.309952952675;12561.685957850945;12569.937150314372;8433.114522975;8455.661773529113;8455.95772021136;8473.83052338962;8560.957195213985;3255.820929848881;3281.868725250963;3311.437055700537;3338.4157772389735;3369.3261347730554;1047.3349423116376;1087.2715280761909;1122.5902545570807;1122.8820973797797;1184.946677399519;30987.380252394825;31254.84372578168;32188.19529511781;32515.18712032171;32935.67064329374;1147.7474955509774;1157.8768594463356;1184.603157942099;1285.774989376874;1323.1069028405789;15909;16064.51806445785;16188.514344569681;16234.18829058566;16447.177641117898;310193;317095;319003;319922;320009.5993280448;57288.713556431954;57944;58148;58263.70868145632;58342.41657583455;1437.6837095838898;1448.2686243447201;1461.7734251191082;1477.7340078785921;1551.945681901128;30678;31467.213319667193;31652.5252121223;31697.46301467574;31986.20034499156;50879.49120508748;51860;51981;52355;52657;417853;423019;423589;423783;424290;43529;43591.34612980871;43651.56348436475;43893.78053109714;43962;47882;47927.28109078297;48275.275870862664;48518.272225917346;49731.75134124306;40695.59304407037;42008;42127.36808947807;42421.36367954545;42536.361954570086;39658.60341396549;40797.1840563193;40878.1824363517;40947.38578921378;41197.382039268836;41021.179576408904;41036.58963410447;42129.36805947975;42465.36301955411;42540.57459425366;33990.66009339875;37113.628863712096;37200;37217.25565488729;37281.254374911805;28667.569986449802;30259;30557.388852223277;30718.23204419818;30997 06:02:51 INFO - PROCESS | 10639 | |2;jquery.html;386.88393481955404;392.82322954670394;398.5874619768542;401.9316716158253;408.5812042656277;14236.501722439716;17540.210690518958;17592.824071759278;18304;18324;18229.544261393472;18525.2589896404;18763;18778.530536736587;18788.71816922747;5419.3225846769155;5486.588505862056;5637.915431268534;5642.04085305499;5645.407232240617;5145.897082058356;5453.427390124039;5577.3028371453565;5590.440955904418;5591.384947655754;5436.130219164935;5444.754986025619;5447.4824891635235;5448.073827449323;5450.209719590657;5493.2034854946005;6004.18943442634;6060.454559089703;6070.514358851281;6105.145279660851;5250.582342767431;5384.946150538483;5386.407495175527;5394.541463975567;5471.863203419906;21504.569908601898;21681.241156559445;21797.67303490449;22049.448763781034;22351.441213969618;2122.8301735861096;2346.073301046077;2379.1078345620394;2386.4153282445914;2433.7809597136165;9631.662891798824;9665.71002869915;9704.320697551175;9775.853362199572;10865.782684346268;1873.9625207495774;1894.2707057782716;1914.339552854263;1927.9325223617107;1964.5285131568464;71982.64008679923;73234.63382683053;77598.6120069396;79731.6013419935;85145;10202.183825293958;10578.365298082139;10654.893451065545;10794.514246858911;10909.454527273605;14207.289635518182;14892.851071489364;14965.92517037408;15016;15029.774553381709;7718.996530451005;7770.572618506037;7867.488613240121;7881.251281128284;8003.839923201504;7141.464390170758;7207.063081799437;7249.528780629243;7495.287947644965;7575.0909890813455;4564.908701825945;4591.035882464653;4629.213033784265;4649.395578574764;4711.316859055418;1933.1204302042536;1950.71714601382;1953.9316123935594;1982;2005.2881227164146;949.4208532794989;1057.5029736024057;1122.9949195470172;1152.4468255237532;1156.9363684997238;18412.447626570956;18414.539636509195;18510.16704248285;18943.62112757737;19187.90406047961;1001.3090967232587;1004.9497525123714;1005.8189525885265;1037.7405648587853;1111.377628528027;9958.203343732484;10504.264701470824;10511.632092876713;10556.102731267929;10576.36541807494;456040;460326;461848;463727;463857;84504;85942.57028714816;86206.56896715476;86446.56776716076;87458;1005.1305620638095;1015.4262841494532;1040.8959104089681;1063.9042486176281;1071.844582535528;16250;16318.428854990017;16495.422660206834;16582.585435364213;16604.66790664204;25521.48957020886;33742.49386259159;35939.64060359363;36346.8182659085;36507.634923650425;42109.78945105255;51300.48699512957;52575.21137183022;52781;53097;7886.605669716606;7959.442839001214;7993;8012.799680008046;8023.598820058857;12477.563285284972;13105.606831795061;13116.737665246832;13135.802962955755;13143.408546615234;11449.053660877504;11603.941980290045;11842.703932401415;11958.222715523463;12032.699182520157;11467.541298347973;11503.309801411942;11589.130815188726;11600;11623.24448910852;11740.943315101682;12014.939925300318;12079.818802717791;12087;12155.149139560146;7832.295093441618;7858.489198202098;8036.758897233092;8105.392095592736;8172.918270817454;8491.278241349308;11625.360605166798;11829.881701182878;11841.111916606116;11984.64046078619 06:02:51 INFO - PROCESS | 10639 | |3;mootools.html;1469.485680011996;1476.9483068092618;1643.6301832087781;1760.2606905099856;1805.7562229099076;7572.697092116323;8075.192480751922;8179.141190175028;8407.663693452263;8462.49225046497;8257;8299.377546684007;8368;8390.95804520978;8395.496270223792;2285.32582888048;2305.4927915858566;2316.8609883406966;2316.980528567425;2325.3256555598855;2244.147224054857;2284.1091974130104;2298.37943755186;2305.4582173189287;2308.122913292946;2276.635738281875;2304.2511183865226;2314.560233555619;2316.8262380321457;2320.037184568402;2259.0399080390766;2259.2770313499686;2263.6265016272296;2265.9886700566476;2270.625346817773;2233.3858188997992;2244.3940136163146;2252.6170551006367;2259.7853203945597;2279.8290128240446;8517.97784265892;8525.360597955178;8557.101504342018;8575.871361929576;8626.353023523261;4825.10735513931;4942.604591632661;4948.257761335793;4975.676581022222;4986.977669577728;3213.53403756454;3258.169166862435;3316.088075779156;3337.4326364518092;3353.798772073659;1078.9406582637953;1079.1744315598573;1088.6951653537021;1108.2020944919645;1112.8942750438696;11188.049015833663;11209.775804483865;11216.102711783038;11244.26912250701;11364.090872730161;4089.6932730045364;4143;4242.215190189825;4267.16790225903;4301.096769678403;9550.761230969281;9592.472414017157;9602.375845570015;9648;9655.372400793925;4881.609471242292;4896.608271338285;4902.48523904992;4908.8772780680765;4917.262410638433;4086.7139300248696;4489.1021795641;4531.207038768202;4611.838585649553;4622.838200662961;3650.123970247175;3691.870784522529;3727.8508859645854;3765.585785563586;3766.7174961877968;1181.173178774861;1212.5089338817793;1239.293602646483;1246.9314187719763;1254.8996080313552;899.3929097858919;962.821877952581;986.9963973134548;1000.1598657128047;1009.5106003566387;5734.483896449339;5865.4427829357;5987.820365389045;6025.6083354581815;6052.909206361908;406.37215502049406;407.43163287214765;408.0431388394211;410.3024857741851;413.08501668803746;3864.840547835638;3937.527496700357;3943.0339566806315;3947.0527073502153;3999.3800960851113;9972.351797133164;10326.122279606167;10589.9470502647;10600.681979540626;10837.18721095921;10519.84220236697;10599.682009539727;10617;10665.200109991627;10693.19801014927;7794.766157015299;8016.118226995026;8090.393220508486;8093.554854482943;8106.837863242702;5712.857178570569;5823.602335439379;5859.44335288147;5904.498117660047;6026.035834266671;9778.315517913677;9837.852432213665;9879.604815807288;9896.950515247665;9905.207583393456;9639.132478077006;9882.061204185591;10036.397816131055;10083.445410502492;10161.695149145537;6813.557118787263;7220.169680486812;7351.4118870489165;7718.807029824299;7771.494852834548;7812.218778122142;7942.205779422012;7972.162922893012;7975;7983.361331093614;7234.710611575478;7430.739924102847;7469.290417410337;7558.622068896643;7630.389568834591;7175.354218120394;7349.191588925107;7391.334779869838;7398.59307738058;7398.926010739824;6702.664866756545;6728.831779205363;6789.456843452611;6798.490113241625;6803.421709154777;4934.901301974012;4949.0101979603505;4971.453140154508;5099.388073431212;5216.921746173734;5036.967421678474;5079.92380114306;5103.693778373309;5150.68657492352;5151 06:02:51 INFO - PROCESS | 10639 | |4;prototype.html;324.1943769732215;329.9606240342919;331.5325391198411;333.2568372529261;339.51279913324373;5744.138379243115;5867.413258674141;5950.38183199392;6012.985649807314;6112.510999120071;5938.257717785277;5972.283326000875;5992.131140984555;5995.100734889757;5999.910001349972;4442.2004039272915;4442.645397939097;4449.198074779703;4474.664400170001;4501.077279157765;4410.2943529035365;4446.333050042487;4471.262241730111;4479.171353299634;4484.080763443486;4390.560943905616;4408.8016039278145;4409.096135292258;4429.379886815848;4433.600975912167;4430.6898517103655;4434.889127771816;4461.754603496806;4486.775661216926;4487.169873573367;3822.808859557039;3881.5342158940825;3897.7466464679987;3912.7065470089856;3925.9792453962177;5740.425957404268;5741.138829175616;5765.827025189251;5776.104703770922;5788.18965344852;5266.815661451869;5273.709945952971;5281.603879709037;5296.947030529684;5297.12597421425;6109.450149486567;6329.1772069631115;6344.619322840645;6356.332585078547;6381.138546296237;4325;4331.133773245364;4332.978335108336;4337.0458499130455;4359.738415695068;6336.17629708135;6597.373249541286;6612.107365505692;6623.105880706091;6636.568623039487;4365.017870979068;4375.6280716138845;4380.4305440292555;4384.649228061748;4386.254336762758;4444.977775111104;4449.154660614473;4453.354263631755;4453.688241823106;4472.888177795516;5201.947980520146;5244.737763111905;5246.580273578104;5263.263143159884;5265.078611243094;6025.3974602540275;6128.816135515942;6309.7160627770945;6381.64900930444;6397.45621622158;1486.2271618758184;1497.1316636351107;1500.5048334049739;1502.0762231227716;1502.1963249661596;993.8620279779611;995.4674249276602;1016.7254841192985;1016.9338992965434;1018.1091544898214;6031.24609423822;6042.909356359658;6061.848453788691;6062.848428789315;6105.481034112061;6443.967780161163;6455.644939528371;6481.773137940149;6542.5933424314;6543.44380727634;5908.231929849092;5996.910046349309;6051.394860513913;6058.666773327509;6069.696515174223;3490.650934906489;3503.737219708532;3510.596281427617;3511.666391692785;3521.506989021539;6591.406773390322;6676.132102826601;6705.832354191184;6711.563748356341;6738.19141702989;6615.801525954229;6715.227748808852;6724.562903411263;6733.663316834139;6742.42689371409;6581.6709164542535;6661.933380666132;6726.697298621574;6744.224414192333;6785.762498312634;6530.510211734234;6535.967320163369;6572.539922205399;6577.473802095917;6582.80251592453;6257.9687101564205;6462.515311351762;6465.450436712932;6466.159399278064;6477.8704425912165;6720.1599800025;6744.7639332625085;6773.322667733188;6790.45676345901;6791.117154769849;4361.803718832597;4390.802413891446;4393.582609652078;4412.779361031871;4422.71252368595;6236.968815155895;6391.265004524354;6487.837804054936;6545.607263564201;6655.966720166368;6235.844103897439;6396.584222025554;6421.903671445026;6459.224893012869;6462.547621666438;6205.503559715122;6329.588576742497;6368.108464814837;6385.776497822554;6418.903716444351;6245.594036387621;6256.968715156395;6257.311695713559;6280.654563998841;6304.968475157595;6319.8104056878365;6376.298607153302;6438.517111216771;6448.387403196689;6476.773312934025;5924.844655292177;6240.781572644935;6265.968670156803;6269.7178626962805;6324.778632748016 06:02:51 INFO - PROCESS | 10639 | |5;yui.html;811.8944537210162;824.9051359093702;827.4786884262913;840.1430540848335;842.8777827215058;13645.522406715767;14249.643758906033;14436.278186090705;14517.056391334569;14521.983461157723;13124.146930449515;13200.603981880535;13228.074034817566;13243.139195952257;13271.071025028252;662.7945336945551;771.1709911844762;802.9156938521459;803.5700900018492;805.3959530352236;793.6150966781136;800.8078061265313;801.9037715474122;802.9357651387875;807.3258828877865;852.8635418333068;855.5850412549909;858.5149390594295;859.2138193552922;859.6088779605296;849.3035710717214;850.8511010573156;855.6449073634466;858.6393714639867;859.6002858670716;623.2334228898435;626.1703243202729;626.1890851347516;626.2516293029786;628.5317438508295;13496.5276215332;13524.93237533816;13527.864721352857;13557.457701691921;13592.864071359358;13518.729625407535;13547.322633868365;13641.317934103256;13663.795043074362;13908.860911390959;11317.490712917855;11329.320240785497;11404.885951140466;11483.368414737186;11496.655100347003;3830.942535861964;3892.746971446847;3915.4909861717792;3978;3983.541892682321;53933.730331348095;54286;54753.45246547563;55247.44752552463;55385;10473.214508911862;10554.313969592105;10606.257561970742;10627.14982801374;10788;19125.61748765017;19132.713009304873;19146.138423770964;19769.232307476967;19828.90085549563;7890.723824666109;8089.150639182919;8200.220979007105;8245.216704413071;8287.254147126667;4527.207738645724;4570.428696412949;4665.2535594304745;4754.168020596382;4774.832880849153;3272;3305.768596198243;3320.0869760815967;3322.186064414234;3324.069260607034;555.0314700846967;557.4753050407134;559.8236555485009;560.5011539729644;560.729946670791;639.7792761497276;659.4361820643377;661.9966900165468;670.6210990790188;690.126989358462;8258.091609922903;8308.5430301334;8380.748577542683;8471.872921906177;8779.473231606124;565.9349174844946;634.3751404866204;635.2345423764353;716.8351279205812;728.3590440412403;3922.2547715933883;3973.106051138471;4001.079751657135;4053.9391909121387;4071.633552980246;65060.34939650543;65429;65719.67140164365;66307.66846165835;66619.33380666228;54363;54794.726026369615;55488.445115548326;55583.444165558634;56299.71850140723;50878.491215088114;50901.72745681313;52049.21926171111;52107.478925210264;52497.737511312196;8044.517328960281;8077.87883181741;8147.837043258983;8186.394849144414;8366.581670916552;33322;33705.83147084249;33900;34576.654233457346;34965.47551786776;41172.588274118076;45701.314480282155;46012.53987460217;46250;46855.53144468512;10423.374597524173;10502.159827213958;10642.680719578426;10687.625933092304;10868.130549556176;11334.206605537533;11452.026577740986;11618;11705.297682139098;12153;11025.152780962368;11235.88764112381;11286.49210785533;11303.321800691985;11338;11400.543978241109;11494.904582145868;11571.826422603499;11591.826122608336;12109.333986630467;10798.460076995962;10848.783024339627;10963.780724385308;11084.722881928017;11106.459747431185;9528.809423811623;9566.330356874952;9665.130138287588;9747.707568772948;10224.28430009922;9724.854127188239;9793.167580755715;9871.770601890934;10022.799544009225;10061.346012509164 06:02:51 INFO - PROCESS | 10639 | __end_tp_report 06:02:51 INFO - PROCESS | 10639 | __start_cc_report 06:02:51 INFO - PROCESS | 10639 | _x_x_mozilla_cycle_collect,350 06:02:51 INFO - PROCESS | 10639 | __end_cc_report 06:02:51 INFO - PROCESS | 10639 | __startTimestamp1461243771479__endTimestamp 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | ------- Summary: start ------- 06:02:51 INFO - PROCESS | 10639 | Number of tests: 6 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | [#0] dojo.html Cycles:165 Average:5374.43 Median:5618.30 stddev:708.45 (12.6%) stddev-sans-first:687.86 06:02:51 INFO - PROCESS | 10639 | Values: 3103.7 3139.5 3199.3 3228.0 3231.9 5464.6 5481.5 5483.2 5483.2 5496.4 5366.7 5425.3 5473.9 5538.6 5567.0 4861.8 4864.3 4924.9 4943.2 4985.4 906.0 4855.9 4937.8 4941.6 4999.3 4908.3 4933.6 4934.7 4939.3 4968.6 4796.1 5008.8 5014.8 5022.7 5062.2 4797.8 4837.3 4845.2 4847.1 4870.0 5355.3 5387.7 5415.7 5425.1 5430.3 5726.1 5806.9 5853.6 5862.5 5866.9 5787.7 5848.6 5856.8 5857.5 5882.5 5341.7 5423.1 5431.7 5447.7 5449.8 5799.6 5926.2 5967.7 6017.7 6061.1 5690.7 5782.5 5786.8 5798.4 5812.9 5835.1 5865.1 5868.9 5870.1 5871.2 5577.5 5664.7 5740.2 5748.0 5790.5 5618.3 5781.5 5798.4 5808.5 5856.1 4393.0 4429.2 4430.1 4437.9 4485.2 3800.1 3906.9 3917.1 3951.3 3973.5 5574.3 5585.1 5587.4 5589.9 5627.6 5770.7 5805.2 5875.6 5883.3 5889.1 5508.6 5517.1 5531.2 5570.0 5586.9 4980.3 4983.8 4985.9 5000.5 5038.4 5788.0 5918.6 5943.0 5952.9 5978.0 5828.3 5864.5 5867.6 5873.5 5890.9 5962.6 6008.0 6018.4 6025.2 6032.5 5623.3 5659.0 5669.3 5757.2 5760.7 5854.0 5875.4 5885.6 5887.4 5898.7 5665.6 5705.9 5710.0 5722.1 5724.5 5428.2 5657.3 5695.6 5741.7 5798.2 5425.5 5513.6 5544.6 5547.0 5606.3 5623.7 5628.4 5628.5 5656.0 5669.2 5562.8 5601.5 5645.7 5646.2 5710.2 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | [#1] ext.html Cycles:180 Average:48672.91 Median:37329.25 stddev:87908.07 (235.5%) stddev-sans-first:88080.50 06:02:51 INFO - PROCESS | 10639 | Values: 574.9 647.0 660.0 666.4 669.2 34839.1 35869.6 36040.8 36065.8 36193.8 41401.6 41808.6 42094.8 42144.8 42153.0 8747.1 8940.1 8952.6 8961.0 8964.6 8721.6 8782.6 8806.5 8811.5 8841.0 8833.4 8887.7 8889.0 8906.7 8921.1 8799.1 8803.7 8831.4 8861.0 8868.7 8774.2 8793.1 8798.3 8849.3 8860.7 30937.5 37168.4 37377.3 37766.0 37778.4 3323.3 3353.4 3530.2 3709.4 3906.3 26071.1 26401.3 26425.5 26886.4 27283.7 3996.3 4023.7 4028.9 4060.7 4103.6 232013.0 232061.0 233430.0 233823.0 234118.0 33206.8 33880.0 34599.5 35251.8 35301.6 35325.6 35573.3 35595.3 35681.5 35686.8 14937.3 15145.3 15180.3 15183.7 15200.0 12475.8 12524.7 12546.3 12561.7 12569.9 8433.1 8455.7 8456.0 8473.8 8561.0 3255.8 3281.9 3311.4 3338.4 3369.3 1047.3 1087.3 1122.6 1122.9 1184.9 30987.4 31254.8 32188.2 32515.2 32935.7 1147.7 1157.9 1184.6 1285.8 1323.1 15909.0 16064.5 16188.5 16234.2 16447.2 310193.0 317095.0 319003.0 319922.0 320009.6 57288.7 57944.0 58148.0 58263.7 58342.4 1437.7 1448.3 1461.8 1477.7 1551.9 30678.0 31467.2 31652.5 31697.5 31986.2 50879.5 51860.0 51981.0 52355.0 52657.0 417853.0 423019.0 423589.0 423783.0 424290.0 43529.0 43591.3 43651.6 43893.8 43962.0 47882.0 47927.3 48275.3 48518.3 49731.8 40695.6 42008.0 42127.4 42421.4 42536.4 39658.6 40797.2 40878.2 40947.4 41197.4 41021.2 41036.6 42129.4 42465.4 42540.6 33990.7 37113.6 37200.0 37217.3 37281.3 28667.6 30259.0 30557.4 30718.2 30997.0 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | [#2] jquery.html Cycles:180 Average:27230.49 Median:2382.76 stddev:75960.67 (3187.9%) stddev-sans-first:76147.02 06:02:51 INFO - PROCESS | 10639 | Values: 386.9 392.8 398.6 401.9 408.6 14236.5 17540.2 17592.8 18304.0 18324.0 18229.5 18525.3 18763.0 18778.5 18788.7 5419.3 5486.6 5637.9 5642.0 5645.4 5145.9 5453.4 5577.3 5590.4 5591.4 5436.1 5444.8 5447.5 5448.1 5450.2 5493.2 6004.2 6060.5 6070.5 6105.1 5250.6 5384.9 5386.4 5394.5 5471.9 21504.6 21681.2 21797.7 22049.4 22351.4 2122.8 2346.1 2379.1 2386.4 2433.8 9631.7 9665.7 9704.3 9775.9 10865.8 1874.0 1894.3 1914.3 1927.9 1964.5 71982.6 73234.6 77598.6 79731.6 85145.0 10202.2 10578.4 10654.9 10794.5 10909.5 14207.3 14892.9 14965.9 15016.0 15029.8 7719.0 7770.6 7867.5 7881.3 8003.8 7141.5 7207.1 7249.5 7495.3 7575.1 4564.9 4591.0 4629.2 4649.4 4711.3 1933.1 1950.7 1953.9 1982.0 2005.3 949.4 1057.5 1123.0 1152.4 1156.9 18412.4 18414.5 18510.2 18943.6 19187.9 1001.3 1004.9 1005.8 1037.7 1111.4 9958.2 10504.3 10511.6 10556.1 10576.4 456040.0 460326.0 461848.0 463727.0 463857.0 84504.0 85942.6 86206.6 86446.6 87458.0 1005.1 1015.4 1040.9 1063.9 1071.8 16250.0 16318.4 16495.4 16582.6 16604.7 25521.5 33742.5 35939.6 36346.8 36507.6 42109.8 51300.5 52575.2 52781.0 53097.0 7886.6 7959.4 7993.0 8012.8 8023.6 12477.6 13105.6 13116.7 13135.8 13143.4 11449.1 11603.9 11842.7 11958.2 12032.7 11467.5 11503.3 11589.1 11600.0 11623.2 11740.9 12014.9 12079.8 12087.0 12155.1 7832.3 7858.5 8036.8 8105.4 8172.9 8491.3 11625.4 11829.9 11841.1 11984.6 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | [#3] mootools.html Cycles:180 Average:5551.83 Median:4889.11 stddev:3146.70 (64.4%) stddev-sans-first:3140.57 06:02:51 INFO - PROCESS | 10639 | Values: 1469.5 1476.9 1643.6 1760.3 1805.8 7572.7 8075.2 8179.1 8407.7 8462.5 8257.0 8299.4 8368.0 8391.0 8395.5 2285.3 2305.5 2316.9 2317.0 2325.3 2244.1 2284.1 2298.4 2305.5 2308.1 2276.6 2304.3 2314.6 2316.8 2320.0 2259.0 2259.3 2263.6 2266.0 2270.6 2233.4 2244.4 2252.6 2259.8 2279.8 8518.0 8525.4 8557.1 8575.9 8626.4 4825.1 4942.6 4948.3 4975.7 4987.0 3213.5 3258.2 3316.1 3337.4 3353.8 1078.9 1079.2 1088.7 1108.2 1112.9 11188.0 11209.8 11216.1 11244.3 11364.1 4089.7 4143.0 4242.2 4267.2 4301.1 9550.8 9592.5 9602.4 9648.0 9655.4 4881.6 4896.6 4902.5 4908.9 4917.3 4086.7 4489.1 4531.2 4611.8 4622.8 3650.1 3691.9 3727.9 3765.6 3766.7 1181.2 1212.5 1239.3 1246.9 1254.9 899.4 962.8 987.0 1000.2 1009.5 5734.5 5865.4 5987.8 6025.6 6052.9 406.4 407.4 408.0 410.3 413.1 3864.8 3937.5 3943.0 3947.1 3999.4 9972.4 10326.1 10589.9 10600.7 10837.2 10519.8 10599.7 10617.0 10665.2 10693.2 7794.8 8016.1 8090.4 8093.6 8106.8 5712.9 5823.6 5859.4 5904.5 6026.0 9778.3 9837.9 9879.6 9897.0 9905.2 9639.1 9882.1 10036.4 10083.4 10161.7 6813.6 7220.2 7351.4 7718.8 7771.5 7812.2 7942.2 7972.2 7975.0 7983.4 7234.7 7430.7 7469.3 7558.6 7630.4 7175.4 7349.2 7391.3 7398.6 7398.9 6702.7 6728.8 6789.5 6798.5 6803.4 4934.9 4949.0 4971.5 5099.4 5216.9 5037.0 5079.9 5103.7 5150.7 5151.0 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | [#4] prototype.html Cycles:180 Average:5261.51 Median:6028.32 stddev:1617.44 (26.8%) stddev-sans-first:1578.95 06:02:51 INFO - PROCESS | 10639 | Values: 324.2 330.0 331.5 333.3 339.5 5744.1 5867.4 5950.4 6013.0 6112.5 5938.3 5972.3 5992.1 5995.1 5999.9 4442.2 4442.6 4449.2 4474.7 4501.1 4410.3 4446.3 4471.3 4479.2 4484.1 4390.6 4408.8 4409.1 4429.4 4433.6 4430.7 4434.9 4461.8 4486.8 4487.2 3822.8 3881.5 3897.7 3912.7 3926.0 5740.4 5741.1 5765.8 5776.1 5788.2 5266.8 5273.7 5281.6 5296.9 5297.1 6109.5 6329.2 6344.6 6356.3 6381.1 4325.0 4331.1 4333.0 4337.0 4359.7 6336.2 6597.4 6612.1 6623.1 6636.6 4365.0 4375.6 4380.4 4384.6 4386.3 4445.0 4449.2 4453.4 4453.7 4472.9 5201.9 5244.7 5246.6 5263.3 5265.1 6025.4 6128.8 6309.7 6381.6 6397.5 1486.2 1497.1 1500.5 1502.1 1502.2 993.9 995.5 1016.7 1016.9 1018.1 6031.2 6042.9 6061.8 6062.8 6105.5 6444.0 6455.6 6481.8 6542.6 6543.4 5908.2 5996.9 6051.4 6058.7 6069.7 3490.7 3503.7 3510.6 3511.7 3521.5 6591.4 6676.1 6705.8 6711.6 6738.2 6615.8 6715.2 6724.6 6733.7 6742.4 6581.7 6661.9 6726.7 6744.2 6785.8 6530.5 6536.0 6572.5 6577.5 6582.8 6258.0 6462.5 6465.5 6466.2 6477.9 6720.2 6744.8 6773.3 6790.5 6791.1 4361.8 4390.8 4393.6 4412.8 4422.7 6237.0 6391.3 6487.8 6545.6 6656.0 6235.8 6396.6 6421.9 6459.2 6462.5 6205.5 6329.6 6368.1 6385.8 6418.9 6245.6 6257.0 6257.3 6280.7 6305.0 6319.8 6376.3 6438.5 6448.4 6476.8 5924.8 6240.8 6266.0 6269.7 6324.8 06:02:51 INFO - PROCESS | 10639 | 06:02:51 INFO - PROCESS | 10639 | [#5] yui.html Cycles:180 Average:14609.44 Median:25804.85 stddev:17568.66 (68.1%) stddev-sans-first:17587.39 06:02:51 INFO - PROCESS | 10639 | Values: 811.9 824.9 827.5 840.1 842.9 13645.5 14249.6 14436.3 14517.1 14522.0 13124.1 13200.6 13228.1 13243.1 13271.1 662.8 771.2 802.9 803.6 805.4 793.6 800.8 801.9 802.9 807.3 852.9 855.6 858.5 859.2 859.6 849.3 850.9 855.6 858.6 859.6 623.2 626.2 626.2 626.3 628.5 13496.5 13524.9 13527.9 13557.5 13592.9 13518.7 13547.3 13641.3 13663.8 13908.9 11317.5 11329.3 11404.9 11483.4 11496.7 3830.9 3892.7 3915.5 3978.0 3983.5 53933.7 54286.0 54753.5 55247.4 55385.0 10473.2 10554.3 10606.3 10627.1 10788.0 19125.6 19132.7 19146.1 19769.2 19828.9 7890.7 8089.2 8200.2 8245.2 8287.3 4527.2 4570.4 4665.3 4754.2 4774.8 3272.0 3305.8 3320.1 3322.2 3324.1 555.0 557.5 559.8 560.5 560.7 639.8 659.4 662.0 670.6 690.1 8258.1 8308.5 8380.7 8471.9 8779.5 565.9 634.4 635.2 716.8 728.4 3922.3 3973.1 4001.1 4053.9 4071.6 65060.3 65429.0 65719.7 66307.7 66619.3 54363.0 54794.7 55488.4 55583.4 56299.7 50878.5 50901.7 52049.2 52107.5 52497.7 8044.5 8077.9 8147.8 8186.4 8366.6 33322.0 33705.8 33900.0 34576.7 34965.5 41172.6 45701.3 46012.5 46250.0 46855.5 10423.4 10502.2 10642.7 10687.6 10868.1 11334.2 11452.0 11618.0 11705.3 12153.0 11025.2 11235.9 11286.5 11303.3 11338.0 11400.5 11494.9 11571.8 11591.8 12109.3 10798.5 10848.8 10963.8 11084.7 11106.5 9528.8 9566.3 9665.1 9747.7 10224.3 9724.9 9793.2 9871.8 10022.8 10061.3 06:02:51 INFO - PROCESS | 10639 | -------- Summary: end -------- 06:02:51 INFO - PROCESS | 10639 | 06:02:52 INFO - TEST-INFO | 10639: exit 0 06:02:52 INFO - TEST-OK | dromaeo_css | took 1109362ms 06:02:52 INFO - TEST-START | kraken 06:02:52 INFO - operating with platform_type : linux_ 06:02:52 INFO - Initialising browser for kraken test... 06:02:52 INFO - TEST-INFO | started process 10870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVoAMj/profile http://localhost:49400/getInfo.html) 06:02:55 INFO - PROCESS | 10870 | 06:02:55 INFO - PROCESS | 10870 | (process:10938): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:02:56 INFO - PROCESS | 10870 | __metrics Screen width/height:1600/1200 06:02:56 INFO - PROCESS | 10870 | colorDepth:24 06:02:56 INFO - PROCESS | 10870 | Browser inner width/height: 1024/697 06:02:56 INFO - PROCESS | 10870 | __metrics 06:02:56 ERROR - PROCESS | 10870 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:02:57 INFO - TEST-INFO | 10870: exit 0 06:02:57 INFO - Browser initialized. 06:02:57 INFO - Running cycle 1/1 for kraken test... 06:02:57 INFO - TEST-INFO | started process 10989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVoAMj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:59 INFO - PROCESS | 10989 | 06:02:59 INFO - PROCESS | 10989 | (process:11050): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:03:09 INFO - PROCESS | 10989 | RSS: Main: 163786752 06:03:09 INFO - PROCESS | 10989 | 06:03:12 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:12 INFO - PROCESS | 10989 | RSS: Main: 168370176 06:03:12 INFO - PROCESS | 10989 | 06:03:15 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-dft) 06:03:16 INFO - PROCESS | 10989 | RSS: Main: 171692032 06:03:16 INFO - PROCESS | 10989 | 06:03:19 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-fft) 06:03:19 INFO - PROCESS | 10989 | RSS: Main: 162508800 06:03:19 INFO - PROCESS | 10989 | 06:03:22 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-oscillator) 06:03:22 INFO - PROCESS | 10989 | RSS: Main: 163885056 06:03:22 INFO - PROCESS | 10989 | 06:03:24 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:25 INFO - PROCESS | 10989 | RSS: Main: 163364864 06:03:25 INFO - PROCESS | 10989 | 06:03:28 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:29 INFO - PROCESS | 10989 | RSS: Main: 163737600 06:03:29 INFO - PROCESS | 10989 | 06:03:32 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:33 INFO - PROCESS | 10989 | RSS: Main: 165949440 06:03:33 INFO - PROCESS | 10989 | 06:03:36 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49400/tests/kraken/driver.html?testName=json-parse-financial) 06:03:36 INFO - PROCESS | 10989 | RSS: Main: 166023168 06:03:36 INFO - PROCESS | 10989 | 06:03:38 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:38 INFO - PROCESS | 10989 | RSS: Main: 166445056 06:03:38 INFO - PROCESS | 10989 | 06:03:40 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:41 INFO - PROCESS | 10989 | RSS: Main: 166240256 06:03:41 INFO - PROCESS | 10989 | 06:03:43 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:44 INFO - PROCESS | 10989 | RSS: Main: 166707200 06:03:44 INFO - PROCESS | 10989 | 06:03:46 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:47 INFO - PROCESS | 10989 | RSS: Main: 167366656 06:03:47 INFO - PROCESS | 10989 | 06:03:50 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:50 INFO - PROCESS | 10989 | RSS: Main: 167383040 06:03:50 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49400/tests/kraken/driver.html?testName=ai-astar) 06:03:52 INFO - PROCESS | 10989 | RSS: Main: 168964096 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | __start_tp_report 06:03:52 INFO - PROCESS | 10989 | _x_x_mozilla_page_load 06:03:52 INFO - PROCESS | 10989 | _x_x_mozilla_page_load_details 06:03:52 INFO - PROCESS | 10989 | |i|pagename|runs| 06:03:52 INFO - PROCESS | 10989 | |0;ai-astar;114;106;111;110;114;124;111;111;111;111 06:03:52 INFO - PROCESS | 10989 | |1;audio-beat-detection;156;132;162;180;130;153;154;129;190;136 06:03:52 INFO - PROCESS | 10989 | |2;audio-dft;162;164;161;162;165;166;172;165;166;164 06:03:52 INFO - PROCESS | 10989 | |3;audio-fft;76;77;74;160;77;74;74;78;163;74 06:03:52 INFO - PROCESS | 10989 | |4;audio-oscillator;93;93;154;93;93;92;145;94;93;159 06:03:52 INFO - PROCESS | 10989 | |5;imaging-gaussian-blur;117;118;117;116;118;117;118;118;117;117 06:03:52 INFO - PROCESS | 10989 | |6;imaging-darkroom;146;146;146;146;149;148;147;147;147;147 06:03:52 INFO - PROCESS | 10989 | |7;imaging-desaturate;95;96;96;95;97;96;95;95;96;95 06:03:52 INFO - PROCESS | 10989 | |8;json-parse-financial;63;58;58;62;64;60;58;80;55;55 06:03:52 INFO - PROCESS | 10989 | |9;json-stringify-tinderbox;61;62;62;61;61;60;60;60;61;60 06:03:52 INFO - PROCESS | 10989 | |10;stanford-crypto-aes;79;77;77;78;80;78;78;78;80;78 06:03:52 INFO - PROCESS | 10989 | |11;stanford-crypto-ccm;133;133;137;125;141;125;130;129;165;128 06:03:52 INFO - PROCESS | 10989 | |12;stanford-crypto-pbkdf2;169;170;171;171;171;175;174;167;171;168 06:03:52 INFO - PROCESS | 10989 | |13;stanford-crypto-sha256-iterative;70;72;76;68;68;68;68;70;68;73 06:03:52 INFO - PROCESS | 10989 | __end_tp_report 06:03:52 INFO - PROCESS | 10989 | __start_cc_report 06:03:52 INFO - PROCESS | 10989 | _x_x_mozilla_cycle_collect,826 06:03:52 INFO - PROCESS | 10989 | __end_cc_report 06:03:52 INFO - PROCESS | 10989 | __startTimestamp1461243832719__endTimestamp 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | ------- Summary: start ------- 06:03:52 INFO - PROCESS | 10989 | Number of tests: 14 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.00 stddev:4.67 (4.2%) stddev-sans-first:4.91 06:03:52 INFO - PROCESS | 10989 | Values: 114.0 106.0 111.0 110.0 114.0 124.0 111.0 111.0 111.0 111.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:155.00 stddev:21.13 (13.6%) stddev-sans-first:22.37 06:03:52 INFO - PROCESS | 10989 | Values: 156.0 132.0 162.0 180.0 130.0 153.0 154.0 129.0 190.0 136.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:3.09 (1.9%) stddev-sans-first:3.12 06:03:52 INFO - PROCESS | 10989 | Values: 162.0 164.0 161.0 162.0 165.0 166.0 172.0 165.0 166.0 164.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:36.30 (48.4%) stddev-sans-first:37.99 06:03:52 INFO - PROCESS | 10989 | Values: 76.0 77.0 74.0 160.0 77.0 74.0 74.0 78.0 163.0 74.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:93.00 stddev:29.02 (31.2%) stddev-sans-first:30.05 06:03:52 INFO - PROCESS | 10989 | Values: 93.0 93.0 154.0 93.0 93.0 92.0 145.0 94.0 93.0 159.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:03:52 INFO - PROCESS | 10989 | Values: 117.0 118.0 117.0 116.0 118.0 117.0 118.0 118.0 117.0 117.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 06:03:52 INFO - PROCESS | 10989 | Values: 146.0 146.0 146.0 146.0 149.0 148.0 147.0 147.0 147.0 147.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 06:03:52 INFO - PROCESS | 10989 | Values: 95.0 96.0 96.0 95.0 97.0 96.0 95.0 95.0 96.0 95.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.00 stddev:7.26 (11.9%) stddev-sans-first:7.67 06:03:52 INFO - PROCESS | 10989 | Values: 63.0 58.0 58.0 62.0 64.0 60.0 58.0 80.0 55.0 55.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 06:03:52 INFO - PROCESS | 10989 | Values: 61.0 62.0 62.0 61.0 61.0 60.0 60.0 60.0 61.0 60.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:1.06 (1.4%) stddev-sans-first:1.09 06:03:52 INFO - PROCESS | 10989 | Values: 79.0 77.0 77.0 78.0 80.0 78.0 78.0 78.0 80.0 78.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:133.00 stddev:11.82 (8.9%) stddev-sans-first:12.52 06:03:52 INFO - PROCESS | 10989 | Values: 133.0 133.0 137.0 125.0 141.0 125.0 130.0 129.0 165.0 128.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.00 stddev:2.45 (1.4%) stddev-sans-first:2.52 06:03:52 INFO - PROCESS | 10989 | Values: 169.0 170.0 171.0 171.0 171.0 175.0 174.0 167.0 171.0 168.0 06:03:52 INFO - PROCESS | 10989 | 06:03:52 INFO - PROCESS | 10989 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.77 (4.0%) stddev-sans-first:2.93 06:03:52 INFO - PROCESS | 10989 | Values: 70.0 72.0 76.0 68.0 68.0 68.0 68.0 70.0 68.0 73.0 06:03:52 INFO - PROCESS | 10989 | -------- Summary: end -------- 06:03:52 INFO - PROCESS | 10989 | 06:03:53 INFO - TEST-INFO | 10989: exit 0 06:03:53 INFO - TEST-OK | kraken | took 61480ms 06:03:53 INFO - SUITE-END | took 1170s 06:03:53 INFO - Completed test suite (00:19:31) 06:03:53 INFO - javascript benchmark 06:03:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.689631036896, 3139.544766008929, 3199.264169241076, 3228.0, 3231.8868839590605, 5464.562834973198, 5481.4518548145215, 5483.150111732688, 5483.232347471348, 5496.3953965063865, 5366.677999320043, 5425.2675888755, 5473.945260547403, 5538.556915446765, 5566.972165139168, 4861.829835955733, 4864.318995340655, 4924.901501969976, 4943.184374578191, 4985.376827896513, 906.0334716602529, 4855.854324370274, 4937.80248790048, 4941.604671626261, 4999.300097986266, 4908.312836202935, 4933.629977751665, 4934.69230653877, 4939.333190019337, 4968.602511799066, 4796.112719146969, 5008.84973450797, 5014.84955451337, 5022.698638081691, 5062.2406639004075, 4797.808087676489, 4837.346958160673, 4845.152098382769, 4847.103285892122, 4869.951300486985, 5355.30381050461, 5387.676739395649, 5415.702136382497, 5425.13197888336, 5430.348358197002, 5726.0838265877255, 5806.883862322772, 5853.64878107315, 5862.50168735658, 5866.853328666817, 5787.71061446926, 5848.649081055108, 5856.795012174596, 5857.47282744555, 5882.470577648032, 5341.67949923002, 5423.105187644073, 5431.728413579305, 5447.727613619343, 5449.754761035763, 5799.594028418054, 5926.199963005025, 5967.671778052249, 6017.669028203403, 6061.060535616986, 5690.7439165237665, 5782.508486778587, 5786.826395208151, 5798.362180160179, 5812.912806307909, 5835.095560188178, 5865.120231965154, 5868.882622347614, 5870.060790273621, 5871.207387002785, 5577.498025177753, 5664.745086471119, 5740.225069615632, 5747.971260143672, 5790.507806836382, 5618.297712785902, 5781.53747700183, 5798.391168927286, 5808.506276966421, 5856.0630299151935, 4393.0, 4429.180601588717, 4430.091831174602, 4437.889052773707, 4485.237509623306, 3800.1449673823167, 3906.921861562753, 3917.0990672145567, 3951.328274193394, 3973.5430425501436, 5574.331080270313, 5585.134304182858, 5587.413321601254, 5589.860253493695, 5627.606067575231, 5770.682612456355, 5805.187273781674, 5875.559333049953, 5883.294004719461, 5889.057750759858, 5508.55931525477, 5517.089680202802, 5531.225628412026, 5569.972150139304, 5586.888262234733, 4980.2778597103215, 4983.750812459362, 4985.925211121836, 5000.474950130257, 5038.370203724535, 5788.0, 5918.556108291809, 5943.049112142036, 5952.880942381128, 5977.970110149508, 5828.329742079715, 5864.530837532901, 5867.618604790675, 5873.471387575139, 5890.941090589039, 5962.642241465526, 6008.0, 6018.3680713524445, 6025.1564780931585, 6032.487238584769, 5623.325200975909, 5659.0, 5669.262995810518, 5757.165211044459, 5760.683162426107, 5854.0, 5875.383084776208, 5885.61743486672, 5887.411258874078, 5898.734556945034, 5665.603407761417, 5705.942940570541, 5710.0, 5722.055860782924, 5724.542036637143, 5428.212909128233, 5657.2928383952, 5695.572832037531, 5741.712914354182, 5798.159266906359, 5425.511703946664, 5513.641613295123, 5544.61187716856, 5547.029269877675, 5606.271184745957, 5623.746931388179, 5628.437156284339, 5628.521575665951, 5655.971720141538, 5669.234653321749, 5562.833115006556, 5601.495865372136, 5645.68948707825, 5646.153077038477, 5710.172025056427], "value": 5328.221796041524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8591595059211, 646.9514786391019, 659.9670016499175, 666.4068978609035, 669.1869378704872, 34839.12902177447, 35869.641303586955, 36040.81979590105, 36065.81967090164, 36193.819030904844, 41401.58598414015, 41808.581914180846, 42094.7895260524, 42144.789276053576, 42153.0, 8747.081556436578, 8940.06129356418, 8952.597133128993, 8960.955195224047, 8964.551772411385, 8721.60752766127, 8782.604782784758, 8806.515641639708, 8811.471311721285, 8841.0, 8833.381663283573, 8887.73336799897, 8888.955555222215, 8906.73279801607, 8921.063288354726, 8799.076097009785, 8803.691870784523, 8831.381803273773, 8860.955695221483, 8868.689595864145, 8774.210321071134, 8793.076726943642, 8798.252148567315, 8849.336299777542, 8860.734177974671, 30937.535936960965, 37168.44247336292, 37377.25245495102, 37766.03456637068, 37778.43332350017, 3323.3391976608673, 3353.446681297583, 3530.188056746937, 3709.3879509880835, 3906.257811015926, 26071.08751193718, 26401.3399665008, 26425.471490570275, 26886.386816791055, 27283.727162728515, 3996.300647386696, 4023.6781057515327, 4028.8992775180855, 4060.675145988314, 4103.589641035903, 232013.0, 232061.0, 233430.0, 233823.0, 234118.0, 33206.8339658305, 33879.967201967964, 34599.4810077849, 35251.82374088113, 35301.64698353035, 35325.646743532234, 35573.28853422917, 35595.28809423797, 35681.46477802835, 35686.821565892526, 14937.327820248114, 15145.318460669296, 15180.316885740169, 15183.696326073637, 15200.0, 12475.812862807064, 12524.68688282782, 12546.309952952675, 12561.685957850945, 12569.937150314372, 8433.114522975, 8455.661773529113, 8455.95772021136, 8473.83052338962, 8560.957195213985, 3255.820929848881, 3281.868725250963, 3311.437055700537, 3338.4157772389735, 3369.3261347730554, 1047.3349423116376, 1087.2715280761909, 1122.5902545570807, 1122.8820973797797, 1184.946677399519, 30987.380252394825, 31254.84372578168, 32188.19529511781, 32515.18712032171, 32935.67064329374, 1147.7474955509774, 1157.8768594463356, 1184.603157942099, 1285.774989376874, 1323.1069028405789, 15909.0, 16064.51806445785, 16188.514344569681, 16234.18829058566, 16447.177641117898, 310193.0, 317095.0, 319003.0, 319922.0, 320009.5993280448, 57288.713556431954, 57944.0, 58148.0, 58263.70868145632, 58342.41657583455, 1437.6837095838898, 1448.2686243447201, 1461.7734251191082, 1477.7340078785921, 1551.945681901128, 30678.0, 31467.213319667193, 31652.5252121223, 31697.46301467574, 31986.20034499156, 50879.49120508748, 51860.0, 51981.0, 52355.0, 52657.0, 417853.0, 423019.0, 423589.0, 423783.0, 424290.0, 43529.0, 43591.34612980871, 43651.56348436475, 43893.78053109714, 43962.0, 47882.0, 47927.28109078297, 48275.275870862664, 48518.272225917346, 49731.75134124306, 40695.59304407037, 42008.0, 42127.36808947807, 42421.36367954545, 42536.361954570086, 39658.60341396549, 40797.1840563193, 40878.1824363517, 40947.38578921378, 41197.382039268836, 41021.179576408904, 41036.58963410447, 42129.36805947975, 42465.36301955411, 42540.57459425366, 33990.66009339875, 37113.628863712096, 37200.0, 37217.25565488729, 37281.254374911805, 28667.569986449802, 30259.0, 30557.388852223277, 30718.23204419818, 30997.0], "value": 18230.581710314513, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.88393481955404, 392.82322954670394, 398.5874619768542, 401.9316716158253, 408.5812042656277, 14236.501722439716, 17540.210690518958, 17592.824071759278, 18304.0, 18324.0, 18229.544261393472, 18525.2589896404, 18763.0, 18778.530536736587, 18788.71816922747, 5419.3225846769155, 5486.588505862056, 5637.915431268534, 5642.04085305499, 5645.407232240617, 5145.897082058356, 5453.427390124039, 5577.3028371453565, 5590.440955904418, 5591.384947655754, 5436.130219164935, 5444.754986025619, 5447.4824891635235, 5448.073827449323, 5450.209719590657, 5493.2034854946005, 6004.18943442634, 6060.454559089703, 6070.514358851281, 6105.145279660851, 5250.582342767431, 5384.946150538483, 5386.407495175527, 5394.541463975567, 5471.863203419906, 21504.569908601898, 21681.241156559445, 21797.67303490449, 22049.448763781034, 22351.441213969618, 2122.8301735861096, 2346.073301046077, 2379.1078345620394, 2386.4153282445914, 2433.7809597136165, 9631.662891798824, 9665.71002869915, 9704.320697551175, 9775.853362199572, 10865.782684346268, 1873.9625207495774, 1894.2707057782716, 1914.339552854263, 1927.9325223617107, 1964.5285131568464, 71982.64008679923, 73234.63382683053, 77598.6120069396, 79731.6013419935, 85145.0, 10202.183825293958, 10578.365298082139, 10654.893451065545, 10794.514246858911, 10909.454527273605, 14207.289635518182, 14892.851071489364, 14965.92517037408, 15016.0, 15029.774553381709, 7718.996530451005, 7770.572618506037, 7867.488613240121, 7881.251281128284, 8003.839923201504, 7141.464390170758, 7207.063081799437, 7249.528780629243, 7495.287947644965, 7575.0909890813455, 4564.908701825945, 4591.035882464653, 4629.213033784265, 4649.395578574764, 4711.316859055418, 1933.1204302042536, 1950.71714601382, 1953.9316123935594, 1982.0, 2005.2881227164146, 949.4208532794989, 1057.5029736024057, 1122.9949195470172, 1152.4468255237532, 1156.9363684997238, 18412.447626570956, 18414.539636509195, 18510.16704248285, 18943.62112757737, 19187.90406047961, 1001.3090967232587, 1004.9497525123714, 1005.8189525885265, 1037.7405648587853, 1111.377628528027, 9958.203343732484, 10504.264701470824, 10511.632092876713, 10556.102731267929, 10576.36541807494, 456040.0, 460326.0, 461848.0, 463727.0, 463857.0, 84504.0, 85942.57028714816, 86206.56896715476, 86446.56776716076, 87458.0, 1005.1305620638095, 1015.4262841494532, 1040.8959104089681, 1063.9042486176281, 1071.844582535528, 16250.0, 16318.428854990017, 16495.422660206834, 16582.585435364213, 16604.66790664204, 25521.48957020886, 33742.49386259159, 35939.64060359363, 36346.8182659085, 36507.634923650425, 42109.78945105255, 51300.48699512957, 52575.21137183022, 52781.0, 53097.0, 7886.605669716606, 7959.442839001214, 7993.0, 8012.799680008046, 8023.598820058857, 12477.563285284972, 13105.606831795061, 13116.737665246832, 13135.802962955755, 13143.408546615234, 11449.053660877504, 11603.941980290045, 11842.703932401415, 11958.222715523463, 12032.699182520157, 11467.541298347973, 11503.309801411942, 11589.130815188726, 11600.0, 11623.24448910852, 11740.943315101682, 12014.939925300318, 12079.818802717791, 12087.0, 12155.149139560146, 7832.295093441618, 7858.489198202098, 8036.758897233092, 8105.392095592736, 8172.918270817454, 8491.278241349308, 11625.360605166798, 11829.881701182878, 11841.111916606116, 11984.64046078619], "value": 8915.516307945863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.485680011996, 1476.9483068092618, 1643.6301832087781, 1760.2606905099856, 1805.7562229099076, 7572.697092116323, 8075.192480751922, 8179.141190175028, 8407.663693452263, 8462.49225046497, 8257.0, 8299.377546684007, 8368.0, 8390.95804520978, 8395.496270223792, 2285.32582888048, 2305.4927915858566, 2316.8609883406966, 2316.980528567425, 2325.3256555598855, 2244.147224054857, 2284.1091974130104, 2298.37943755186, 2305.4582173189287, 2308.122913292946, 2276.635738281875, 2304.2511183865226, 2314.560233555619, 2316.8262380321457, 2320.037184568402, 2259.0399080390766, 2259.2770313499686, 2263.6265016272296, 2265.9886700566476, 2270.625346817773, 2233.3858188997992, 2244.3940136163146, 2252.6170551006367, 2259.7853203945597, 2279.8290128240446, 8517.97784265892, 8525.360597955178, 8557.101504342018, 8575.871361929576, 8626.353023523261, 4825.10735513931, 4942.604591632661, 4948.257761335793, 4975.676581022222, 4986.977669577728, 3213.53403756454, 3258.169166862435, 3316.088075779156, 3337.4326364518092, 3353.798772073659, 1078.9406582637953, 1079.1744315598573, 1088.6951653537021, 1108.2020944919645, 1112.8942750438696, 11188.049015833663, 11209.775804483865, 11216.102711783038, 11244.26912250701, 11364.090872730161, 4089.6932730045364, 4143.0, 4242.215190189825, 4267.16790225903, 4301.096769678403, 9550.761230969281, 9592.472414017157, 9602.375845570015, 9648.0, 9655.372400793925, 4881.609471242292, 4896.608271338285, 4902.48523904992, 4908.8772780680765, 4917.262410638433, 4086.7139300248696, 4489.1021795641, 4531.207038768202, 4611.838585649553, 4622.838200662961, 3650.123970247175, 3691.870784522529, 3727.8508859645854, 3765.585785563586, 3766.7174961877968, 1181.173178774861, 1212.5089338817793, 1239.293602646483, 1246.9314187719763, 1254.8996080313552, 899.3929097858919, 962.821877952581, 986.9963973134548, 1000.1598657128047, 1009.5106003566387, 5734.483896449339, 5865.4427829357, 5987.820365389045, 6025.6083354581815, 6052.909206361908, 406.37215502049406, 407.43163287214765, 408.0431388394211, 410.3024857741851, 413.08501668803746, 3864.840547835638, 3937.527496700357, 3943.0339566806315, 3947.0527073502153, 3999.3800960851113, 9972.351797133164, 10326.122279606167, 10589.9470502647, 10600.681979540626, 10837.18721095921, 10519.84220236697, 10599.682009539727, 10617.0, 10665.200109991627, 10693.19801014927, 7794.766157015299, 8016.118226995026, 8090.393220508486, 8093.554854482943, 8106.837863242702, 5712.857178570569, 5823.602335439379, 5859.44335288147, 5904.498117660047, 6026.035834266671, 9778.315517913677, 9837.852432213665, 9879.604815807288, 9896.950515247665, 9905.207583393456, 9639.132478077006, 9882.061204185591, 10036.397816131055, 10083.445410502492, 10161.695149145537, 6813.557118787263, 7220.169680486812, 7351.4118870489165, 7718.807029824299, 7771.494852834548, 7812.218778122142, 7942.205779422012, 7972.162922893012, 7975.0, 7983.361331093614, 7234.710611575478, 7430.739924102847, 7469.290417410337, 7558.622068896643, 7630.389568834591, 7175.354218120394, 7349.191588925107, 7391.334779869838, 7398.59307738058, 7398.926010739824, 6702.664866756545, 6728.831779205363, 6789.456843452611, 6798.490113241625, 6803.421709154777, 4934.901301974012, 4949.0101979603505, 4971.453140154508, 5099.388073431212, 5216.921746173734, 5036.967421678474, 5079.92380114306, 5103.693778373309, 5150.68657492352, 5151.0], "value": 4383.366215607545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.1943769732215, 329.9606240342919, 331.5325391198411, 333.2568372529261, 339.51279913324373, 5744.138379243115, 5867.413258674141, 5950.38183199392, 6012.985649807314, 6112.510999120071, 5938.257717785277, 5972.283326000875, 5992.131140984555, 5995.100734889757, 5999.910001349972, 4442.2004039272915, 4442.645397939097, 4449.198074779703, 4474.664400170001, 4501.077279157765, 4410.2943529035365, 4446.333050042487, 4471.262241730111, 4479.171353299634, 4484.080763443486, 4390.560943905616, 4408.8016039278145, 4409.096135292258, 4429.379886815848, 4433.600975912167, 4430.6898517103655, 4434.889127771816, 4461.754603496806, 4486.775661216926, 4487.169873573367, 3822.808859557039, 3881.5342158940825, 3897.7466464679987, 3912.7065470089856, 3925.9792453962177, 5740.425957404268, 5741.138829175616, 5765.827025189251, 5776.104703770922, 5788.18965344852, 5266.815661451869, 5273.709945952971, 5281.603879709037, 5296.947030529684, 5297.12597421425, 6109.450149486567, 6329.1772069631115, 6344.619322840645, 6356.332585078547, 6381.138546296237, 4325.0, 4331.133773245364, 4332.978335108336, 4337.0458499130455, 4359.738415695068, 6336.17629708135, 6597.373249541286, 6612.107365505692, 6623.105880706091, 6636.568623039487, 4365.017870979068, 4375.6280716138845, 4380.4305440292555, 4384.649228061748, 4386.254336762758, 4444.977775111104, 4449.154660614473, 4453.354263631755, 4453.688241823106, 4472.888177795516, 5201.947980520146, 5244.737763111905, 5246.580273578104, 5263.263143159884, 5265.078611243094, 6025.3974602540275, 6128.816135515942, 6309.7160627770945, 6381.64900930444, 6397.45621622158, 1486.2271618758184, 1497.1316636351107, 1500.5048334049739, 1502.0762231227716, 1502.1963249661596, 993.8620279779611, 995.4674249276602, 1016.7254841192985, 1016.9338992965434, 1018.1091544898214, 6031.24609423822, 6042.909356359658, 6061.848453788691, 6062.848428789315, 6105.481034112061, 6443.967780161163, 6455.644939528371, 6481.773137940149, 6542.5933424314, 6543.44380727634, 5908.231929849092, 5996.910046349309, 6051.394860513913, 6058.666773327509, 6069.696515174223, 3490.650934906489, 3503.737219708532, 3510.596281427617, 3511.666391692785, 3521.506989021539, 6591.406773390322, 6676.132102826601, 6705.832354191184, 6711.563748356341, 6738.19141702989, 6615.801525954229, 6715.227748808852, 6724.562903411263, 6733.663316834139, 6742.42689371409, 6581.6709164542535, 6661.933380666132, 6726.697298621574, 6744.224414192333, 6785.762498312634, 6530.510211734234, 6535.967320163369, 6572.539922205399, 6577.473802095917, 6582.80251592453, 6257.9687101564205, 6462.515311351762, 6465.450436712932, 6466.159399278064, 6477.8704425912165, 6720.1599800025, 6744.7639332625085, 6773.322667733188, 6790.45676345901, 6791.117154769849, 4361.803718832597, 4390.802413891446, 4393.582609652078, 4412.779361031871, 4422.71252368595, 6236.968815155895, 6391.265004524354, 6487.837804054936, 6545.607263564201, 6655.966720166368, 6235.844103897439, 6396.584222025554, 6421.903671445026, 6459.224893012869, 6462.547621666438, 6205.503559715122, 6329.588576742497, 6368.108464814837, 6385.776497822554, 6418.903716444351, 6245.594036387621, 6256.968715156395, 6257.311695713559, 6280.654563998841, 6304.968475157595, 6319.8104056878365, 6376.298607153302, 6438.517111216771, 6448.387403196689, 6476.773312934025, 5924.844655292177, 6240.781572644935, 6265.968670156803, 6269.7178626962805, 6324.778632748016], "value": 4727.741578599673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.8944537210162, 824.9051359093702, 827.4786884262913, 840.1430540848335, 842.8777827215058, 13645.522406715767, 14249.643758906033, 14436.278186090705, 14517.056391334569, 14521.983461157723, 13124.146930449515, 13200.603981880535, 13228.074034817566, 13243.139195952257, 13271.071025028252, 662.7945336945551, 771.1709911844762, 802.9156938521459, 803.5700900018492, 805.3959530352236, 793.6150966781136, 800.8078061265313, 801.9037715474122, 802.9357651387875, 807.3258828877865, 852.8635418333068, 855.5850412549909, 858.5149390594295, 859.2138193552922, 859.6088779605296, 849.3035710717214, 850.8511010573156, 855.6449073634466, 858.6393714639867, 859.6002858670716, 623.2334228898435, 626.1703243202729, 626.1890851347516, 626.2516293029786, 628.5317438508295, 13496.5276215332, 13524.93237533816, 13527.864721352857, 13557.457701691921, 13592.864071359358, 13518.729625407535, 13547.322633868365, 13641.317934103256, 13663.795043074362, 13908.860911390959, 11317.490712917855, 11329.320240785497, 11404.885951140466, 11483.368414737186, 11496.655100347003, 3830.942535861964, 3892.746971446847, 3915.4909861717792, 3978.0, 3983.541892682321, 53933.730331348095, 54286.0, 54753.45246547563, 55247.44752552463, 55385.0, 10473.214508911862, 10554.313969592105, 10606.257561970742, 10627.14982801374, 10788.0, 19125.61748765017, 19132.713009304873, 19146.138423770964, 19769.232307476967, 19828.90085549563, 7890.723824666109, 8089.150639182919, 8200.220979007105, 8245.216704413071, 8287.254147126667, 4527.207738645724, 4570.428696412949, 4665.2535594304745, 4754.168020596382, 4774.832880849153, 3272.0, 3305.768596198243, 3320.0869760815967, 3322.186064414234, 3324.069260607034, 555.0314700846967, 557.4753050407134, 559.8236555485009, 560.5011539729644, 560.729946670791, 639.7792761497276, 659.4361820643377, 661.9966900165468, 670.6210990790188, 690.126989358462, 8258.091609922903, 8308.5430301334, 8380.748577542683, 8471.872921906177, 8779.473231606124, 565.9349174844946, 634.3751404866204, 635.2345423764353, 716.8351279205812, 728.3590440412403, 3922.2547715933883, 3973.106051138471, 4001.079751657135, 4053.9391909121387, 4071.633552980246, 65060.34939650543, 65429.0, 65719.67140164365, 66307.66846165835, 66619.33380666228, 54363.0, 54794.726026369615, 55488.445115548326, 55583.444165558634, 56299.71850140723, 50878.491215088114, 50901.72745681313, 52049.21926171111, 52107.478925210264, 52497.737511312196, 8044.517328960281, 8077.87883181741, 8147.837043258983, 8186.394849144414, 8366.581670916552, 33322.0, 33705.83147084249, 33900.0, 34576.654233457346, 34965.47551786776, 41172.588274118076, 45701.314480282155, 46012.53987460217, 46250.0, 46855.53144468512, 10423.374597524173, 10502.159827213958, 10642.680719578426, 10687.625933092304, 10868.130549556176, 11334.206605537533, 11452.026577740986, 11618.0, 11705.297682139098, 12153.0, 11025.152780962368, 11235.88764112381, 11286.49210785533, 11303.321800691985, 11338.0, 11400.543978241109, 11494.904582145868, 11571.826422603499, 11591.826122608336, 12109.333986630467, 10798.460076995962, 10848.783024339627, 10963.780724385308, 11084.722881928017, 11106.459747431185, 9528.809423811623, 9566.330356874952, 9665.130138287588, 9747.707568772948, 10224.28430009922, 9724.854127188239, 9793.167580755715, 9871.770601890934, 10022.799544009225, 10061.346012509164], "value": 6489.934367815395, "unit": "score"}], "name": "dromaeo_css", "value": 6988.409654235881, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 111.0, 110.0, 114.0, 124.0, 111.0, 111.0, 111.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 162.0, 180.0, 130.0, 153.0, 154.0, 129.0, 190.0, 136.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 162.0, 165.0, 166.0, 172.0, 165.0, 166.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 160.0, 77.0, 74.0, 74.0, 78.0, 163.0, 74.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 154.0, 93.0, 93.0, 92.0, 145.0, 94.0, 93.0, 159.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 149.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 58.0, 58.0, 62.0, 64.0, 60.0, 58.0, 80.0, 55.0, 55.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 78.0, 80.0, 78.0, 78.0, 78.0, 80.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 137.0, 125.0, 141.0, 125.0, 130.0, 129.0, 165.0, 128.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 171.0, 171.0, 171.0, 175.0, 174.0, 167.0, 171.0, 168.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 76.0, 68.0, 68.0, 68.0, 68.0, 70.0, 68.0, 73.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1568.3999999999996, "alertThreshold": 2.0}]} 06:03:53 INFO - Return code: 0 06:03:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:03:54 ERROR - # TBPL SUCCESS # 06:03:54 INFO - Running post-action listener: _resource_record_post_action 06:03:54 INFO - Running post-run listener: _resource_record_post_run 06:03:55 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536870912; Read time: 12; Write time: 411440 06:03:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244318208; Read time: 0; Write time: 211452 06:03:55 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292384768; Read time: 12; Write time: 199964 06:03:55 INFO - Running post-run listener: _upload_blobber_files 06:03:55 INFO - Blob upload gear active. 06:03:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:55 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 06:03:55 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:03:55 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:03:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:03:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:03:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:56 INFO - (blobuploader) - INFO - Done attempting. 06:03:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:03:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:57 INFO - (blobuploader) - INFO - Done attempting. 06:03:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:57 INFO - Return code: 0 06:03:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb770c357668c75dc19cd77e94b74cc21c6571f3e59022f2050f1c5f070740fef794f8f03bf21d2d97f6f58d66f8aa2f69f4bd5ab370580e37aa7495e7bfc0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a641f08c16015ac893a4ee5b0f2016a22acecdca9902c85f138042642c025557c723de203759d8671b76d2f86f246140dd53f5f753dc2a4e0cacf2eadbfa1a9"} 06:03:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:57 INFO - Contents: 06:03:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb770c357668c75dc19cd77e94b74cc21c6571f3e59022f2050f1c5f070740fef794f8f03bf21d2d97f6f58d66f8aa2f69f4bd5ab370580e37aa7495e7bfc0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a641f08c16015ac893a4ee5b0f2016a22acecdca9902c85f138042642c025557c723de203759d8671b76d2f86f246140dd53f5f753dc2a4e0cacf2eadbfa1a9"} 06:03:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:57 INFO - Copying logs to upload dir... 06:03:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.887954 ========= master_lag: 27.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-21 06:04:24.666847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:24.670480) ========= 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=6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838 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/sha512/7bb770c357668c75dc19cd77e94b74cc21c6571f3e59022f2050f1c5f070740fef794f8f03bf21d2d97f6f58d66f8aa2f69f4bd5ab370580e37aa7495e7bfc0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a641f08c16015ac893a4ee5b0f2016a22acecdca9902c85f138042642c025557c723de203759d8671b76d2f86f246140dd53f5f753dc2a4e0cacf2eadbfa1a9"} build_url:https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/KpiYzl5KSwmGLR9w_aPd2g/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/sha512/7bb770c357668c75dc19cd77e94b74cc21c6571f3e59022f2050f1c5f070740fef794f8f03bf21d2d97f6f58d66f8aa2f69f4bd5ab370580e37aa7495e7bfc0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a641f08c16015ac893a4ee5b0f2016a22acecdca9902c85f138042642c025557c723de203759d8671b76d2f86f246140dd53f5f753dc2a4e0cacf2eadbfa1a9"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:25.036230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:25.036644) ========= 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=6dbc10da6d83fee962c624be000001a8-1461241787.917468-242866838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:04:25.265336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:04:25.265619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:04:25.948967) ========= ========= Total master_lag: 28.08 =========