builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1461156383.43 results: success (0) buildid: 20160420030213 builduid: 279ad7011dbe471497873fe8d0a2edca revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.427352) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.427835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.428202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.445653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.445917) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 05:46:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-04-20 05:46:23 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.535842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.536240) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015505 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:23.586487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 05:46:23.586916) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f05a1242fb29023bd7ebc492897ed3d6907733c7 --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 f05a1242fb29023bd7ebc492897ed3d6907733c7 --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=74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 05:46:23,623 truncating revision to first 12 chars 2016-04-20 05:46:23,623 Setting DEBUG logging. 2016-04-20 05:46:23,623 attempt 1/10 2016-04-20 05:46:23,623 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f05a1242fb29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 05:46:24,492 unpacking tar archive at: mozilla-central-f05a1242fb29/testing/mozharness/ program finished with exit code 0 elapsedTime=1.141785 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 05:46:24.742444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:24.742852) ========= script_repo_revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:24.743332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:24.743611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 05:46:24.752177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-20 05:46:24.752530) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:24 INFO - MultiFileLogger online at 20160420 05:46:24 in /builds/slave/test 05:46:24 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:46:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:24 INFO - {'append_to_log': False, 05:46:24 INFO - 'base_work_dir': '/builds/slave/test', 05:46:24 INFO - 'blob_upload_branch': 'Firefox', 05:46:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:24 INFO - 'branch': 'Firefox', 05:46:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:24 INFO - 'config_files': ('talos/linux_config.py',), 05:46:24 INFO - 'default_actions': ('clobber', 05:46:24 INFO - 'read-buildbot-config', 05:46:24 INFO - 'download-and-extract', 05:46:24 INFO - 'populate-webroot', 05:46:24 INFO - 'create-virtualenv', 05:46:24 INFO - 'install', 05:46:24 INFO - 'run-tests'), 05:46:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:24 INFO - 'download_minidump_stackwalk': True, 05:46:24 INFO - 'download_symbols': 'ondemand', 05:46:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:24 INFO - 'installer_path': 'installer.exe', 05:46:24 INFO - 'log_level': 'info', 05:46:24 INFO - 'log_name': 'talos', 05:46:24 INFO - 'log_to_console': True, 05:46:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:24 INFO - 'opt_config_files': (), 05:46:24 INFO - 'pip_index': False, 05:46:24 INFO - 'sps_profile': False, 05:46:24 INFO - 'sps_profile_interval': 0, 05:46:24 INFO - 'suite': 'dromaeojs-e10s', 05:46:24 INFO - 'system_bits': '32', 05:46:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:24 INFO - 'title': 'talos-linux64-ix-042', 05:46:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:24 INFO - 'use_talos_json': True, 05:46:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:24 INFO - 'work_dir': 'build'} 05:46:24 INFO - ##### 05:46:24 INFO - ##### Running clobber step. 05:46:24 INFO - ##### 05:46:24 INFO - Running pre-action listener: _resource_record_pre_action 05:46:24 INFO - Running main action method: clobber 05:46:24 INFO - rmtree: /builds/slave/test/build 05:46:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:25 INFO - Running post-action listener: _resource_record_post_action 05:46:25 INFO - ##### 05:46:25 INFO - ##### Running read-buildbot-config step. 05:46:25 INFO - ##### 05:46:25 INFO - Running pre-action listener: _resource_record_pre_action 05:46:25 INFO - Running main action method: read_buildbot_config 05:46:25 INFO - Using buildbot properties: 05:46:25 INFO - { 05:46:25 INFO - "project": "", 05:46:25 INFO - "product": "firefox", 05:46:25 INFO - "script_repo_revision": "production", 05:46:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:46:25 INFO - "repository": "", 05:46:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:46:25 INFO - "buildid": "20160420030213", 05:46:25 INFO - "stage_platform": "linux64-pgo", 05:46:25 INFO - "basedir": "/builds/slave/test", 05:46:25 INFO - "nightly_build": "True", 05:46:25 INFO - "buildnumber": 706, 05:46:25 INFO - "slavename": "talos-linux64-ix-042", 05:46:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:46:25 INFO - "platform": "ubuntu64_hw", 05:46:25 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:46:25 INFO - "branch": "mozilla-central", 05:46:25 INFO - "repo_path": "mozilla-central", 05:46:25 INFO - "revision": "f05a1242fb29023bd7ebc492897ed3d6907733c7", 05:46:25 INFO - "pgo_build": "True", 05:46:25 INFO - "builduid": "279ad7011dbe471497873fe8d0a2edca", 05:46:25 INFO - "slavebuilddir": "test" 05:46:25 INFO - } 05:46:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:46:25 INFO - Running post-action listener: _resource_record_post_action 05:46:25 INFO - ##### 05:46:25 INFO - ##### Running download-and-extract step. 05:46:25 INFO - ##### 05:46:25 INFO - Running pre-action listener: _resource_record_pre_action 05:46:25 INFO - Running main action method: download_and_extract 05:46:25 INFO - mkdir: /builds/slave/test/build/tests 05:46:25 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:46:25 INFO - https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:46:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:46:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:46:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:26 INFO - Downloaded 1361 bytes. 05:46:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:46:26 INFO - Using the following test package requirements: 05:46:26 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:46:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:46:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'jsshell-linux-x86_64.zip'], 05:46:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:46:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:46:26 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:46:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:46:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:46:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:26 INFO - https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:46:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:46:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:29 INFO - Downloaded 23838898 bytes. 05:46:29 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:46:29 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:46:30 INFO - Return code: 0 05:46:30 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:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:30 INFO - https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:46:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:46:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:44 INFO - Downloaded 23838898 bytes. 05:46:44 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:46:44 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:46:46 INFO - Return code: 0 05:46: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:46:46 INFO - https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:46:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:47 INFO - Downloaded 10845952 bytes. 05:46:47 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:46:47 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:46:47 INFO - Return code: 0 05:46:47 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:46:47 INFO - https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:46:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqO4xUwjSneAGYDXyFA-og/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:46:49 INFO - Downloaded 58305638 bytes. 05:46:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:49 INFO - mkdir: /builds/slave/test/properties 05:46:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:49 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:49 INFO - Contents: 05:46:49 INFO - build_url:https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:50 INFO - Running post-action listener: _resource_record_post_action 05:46:50 INFO - Running post-action listener: set_extra_try_arguments 05:46:50 INFO - ##### 05:46:50 INFO - ##### Running populate-webroot step. 05:46:50 INFO - ##### 05:46:50 INFO - Running pre-action listener: _resource_record_pre_action 05:46:50 INFO - Running main action method: populate_webroot 05:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:50 INFO - '--tppagecycles', 05:46:50 INFO - '7'], 05:46:50 INFO - 'tests': ['tsvgm']}}, 05:46:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['damp', 'tps']}, 05:46:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'tests': ['damp', 'tps']}, 05:46:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['dromaeo_dom']}, 05:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['a11yr', 05:46:50 INFO - 'ts_paint', 05:46:50 INFO - 'tpaint', 05:46:50 INFO - 'sessionrestore', 05:46:50 INFO - 'sessionrestore_no_auto_restore', 05:46:50 INFO - 'tabpaint']}, 05:46:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:50 INFO - 'ts_paint', 05:46:50 INFO - 'tpaint', 05:46:50 INFO - 'sessionrestore', 05:46:50 INFO - 'sessionrestore_no_auto_restore', 05:46:50 INFO - 'tabpaint']}, 05:46:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:50 INFO - 'ts_paint', 05:46:50 INFO - 'tpaint', 05:46:50 INFO - 'sessionrestore', 05:46:50 INFO - 'sessionrestore_no_auto_restore', 05:46:50 INFO - 'tabpaint']}, 05:46:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:50 INFO - 'ts_paint', 05:46:50 INFO - 'tpaint', 05:46:50 INFO - 'sessionrestore', 05:46:50 INFO - 'sessionrestore_no_auto_restore', 05:46:50 INFO - 'tabpaint']}, 05:46:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['a11yr', 05:46:50 INFO - 'ts_paint', 05:46:50 INFO - 'tpaint', 05:46:50 INFO - 'sessionrestore', 05:46:50 INFO - 'sessionrestore_no_auto_restore', 05:46:50 INFO - 'tabpaint']}, 05:46:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['a11yr', 05:46:50 INFO - 'ts_paint', 05:46:50 INFO - 'tpaint', 05:46:50 INFO - 'sessionrestore', 05:46:50 INFO - 'sessionrestore_no_auto_restore', 05:46:50 INFO - 'tabpaint']}, 05:46:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['tsvgx', 05:46:50 INFO - 'tsvgr_opacity', 05:46:50 INFO - 'tart', 05:46:50 INFO - 'tscrollx', 05:46:50 INFO - 'cart']}, 05:46:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:50 INFO - 'tsvgr_opacity', 05:46:50 INFO - 'tart', 05:46:50 INFO - 'tscrollx', 05:46:50 INFO - 'cart']}, 05:46:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'talos_options': ['--disable-e10s'], 05:46:50 INFO - 'tests': ['tp5o']}, 05:46:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'tests': ['tp5o']}, 05:46:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'talos_options': ['--disable-e10s', 05:46:50 INFO - '--xperf_path', 05:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:50 INFO - 'tests': ['tp5n']}, 05:46:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:50 INFO - 'talos_options': ['--xperf_path', 05:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:50 INFO - 'tests': ['tp5n']}}, 05:46:50 INFO - 'talos.zip': {'path': '', 05:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:50 INFO - Running post-action listener: _resource_record_post_action 05:46:50 INFO - ##### 05:46:50 INFO - ##### Running create-virtualenv step. 05:46:50 INFO - ##### 05:46:50 INFO - Running pre-action listener: _resource_record_pre_action 05:46:50 INFO - Running main action method: create_virtualenv 05:46:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:50 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:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:50 INFO - Using real prefix '/usr' 05:46:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:52 INFO - Installing pip.................done. 05:46:52 INFO - Return code: 0 05:46:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:52 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:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:52 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:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:52 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:46:52 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:46:52 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:46:52 INFO - Using env: {'DISPLAY': ':0', 05:46:52 INFO - 'HOME': '/home/cltbld', 05:46:52 INFO - 'LANG': 'en_US.UTF-8', 05:46:52 INFO - 'LANGUAGE': 'en_US:en', 05:46:52 INFO - 'LOGNAME': 'cltbld', 05:46:52 INFO - 'MAIL': '/var/mail/cltbld', 05:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:52 INFO - 'MOZ_NO_REMOTE': '1', 05:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:52 INFO - 'NO_EM_RESTART': '1', 05:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:52 INFO - 'PWD': '/builds/slave/test', 05:46:52 INFO - 'SHELL': '/bin/bash', 05:46:52 INFO - 'SHLVL': '1', 05:46:52 INFO - 'TERM': 'linux', 05:46:52 INFO - 'TMOUT': '86400', 05:46:52 INFO - 'USER': 'cltbld', 05:46:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:52 INFO - '_': '/tools/buildbot/bin/python'} 05:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:52 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:46:52 INFO - Cleaning up... 05:46:52 INFO - Return code: 0 05:46:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:46:52 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:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:52 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:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:52 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:46:52 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:46:52 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:46:52 INFO - Using env: {'DISPLAY': ':0', 05:46:52 INFO - 'HOME': '/home/cltbld', 05:46:52 INFO - 'LANG': 'en_US.UTF-8', 05:46:52 INFO - 'LANGUAGE': 'en_US:en', 05:46:52 INFO - 'LOGNAME': 'cltbld', 05:46:52 INFO - 'MAIL': '/var/mail/cltbld', 05:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:52 INFO - 'MOZ_NO_REMOTE': '1', 05:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:52 INFO - 'NO_EM_RESTART': '1', 05:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:52 INFO - 'PWD': '/builds/slave/test', 05:46:52 INFO - 'SHELL': '/bin/bash', 05:46:52 INFO - 'SHLVL': '1', 05:46:52 INFO - 'TERM': 'linux', 05:46:52 INFO - 'TMOUT': '86400', 05:46:52 INFO - 'USER': 'cltbld', 05:46:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:52 INFO - '_': '/tools/buildbot/bin/python'} 05:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:53 INFO - Downloading/unpacking psutil>=0.7.1 05:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:56 INFO - Installing collected packages: psutil 05:46:56 INFO - Running setup.py install for psutil 05:46:56 INFO - building 'psutil._psutil_linux' extension 05:46:56 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:46:56 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:46:56 INFO - building 'psutil._psutil_posix' extension 05:46:56 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:46:56 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:46:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:56 INFO - Successfully installed psutil 05:46:56 INFO - Cleaning up... 05:46:56 INFO - Return code: 0 05:46:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:46:56 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:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 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:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:46:56 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:46:56 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:46:56 INFO - Using env: {'DISPLAY': ':0', 05:46:56 INFO - 'HOME': '/home/cltbld', 05:46:56 INFO - 'LANG': 'en_US.UTF-8', 05:46:56 INFO - 'LANGUAGE': 'en_US:en', 05:46:56 INFO - 'LOGNAME': 'cltbld', 05:46:56 INFO - 'MAIL': '/var/mail/cltbld', 05:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:56 INFO - 'MOZ_NO_REMOTE': '1', 05:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:56 INFO - 'NO_EM_RESTART': '1', 05:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:56 INFO - 'PWD': '/builds/slave/test', 05:46:56 INFO - 'SHELL': '/bin/bash', 05:46:56 INFO - 'SHLVL': '1', 05:46:56 INFO - 'TERM': 'linux', 05:46:56 INFO - 'TMOUT': '86400', 05:46:56 INFO - 'USER': 'cltbld', 05:46:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:56 INFO - '_': '/tools/buildbot/bin/python'} 05:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:58 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:46:58 INFO - Installing collected packages: mozsystemmonitor 05:46:58 INFO - Running setup.py install for mozsystemmonitor 05:46:59 INFO - Successfully installed mozsystemmonitor 05:46:59 INFO - Cleaning up... 05:46:59 INFO - Return code: 0 05:46:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46: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:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', '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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:46: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 blobuploader==1.2.4 05:46:59 INFO - Using env: {'DISPLAY': ':0', 05:46:59 INFO - 'HOME': '/home/cltbld', 05:46:59 INFO - 'LANG': 'en_US.UTF-8', 05:46:59 INFO - 'LANGUAGE': 'en_US:en', 05:46:59 INFO - 'LOGNAME': 'cltbld', 05:46:59 INFO - 'MAIL': '/var/mail/cltbld', 05:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:59 INFO - 'MOZ_NO_REMOTE': '1', 05:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:59 INFO - 'NO_EM_RESTART': '1', 05:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:59 INFO - 'PWD': '/builds/slave/test', 05:46:59 INFO - 'SHELL': '/bin/bash', 05:46:59 INFO - 'SHLVL': '1', 05:46:59 INFO - 'TERM': 'linux', 05:46:59 INFO - 'TMOUT': '86400', 05:46:59 INFO - 'USER': 'cltbld', 05:46:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:59 INFO - '_': '/tools/buildbot/bin/python'} 05:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:46: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:46: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:46: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:46: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:46: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:46: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:47:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47: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:47: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:47: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:47: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:47: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:47: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:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47: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:47: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:47: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:47: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:47: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:47: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:47:01 INFO - Downloading docopt-0.6.1.tar.gz 05:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:01 INFO - Running setup.py install for blobuploader 05:47:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:02 INFO - Running setup.py install for requests 05:47:02 INFO - Running setup.py install for docopt 05:47:02 INFO - Successfully installed blobuploader requests docopt 05:47:02 INFO - Cleaning up... 05:47:02 INFO - Return code: 0 05:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:02 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:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:02 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:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:02 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:47:02 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:47:02 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:47:02 INFO - Using env: {'DISPLAY': ':0', 05:47:02 INFO - 'HOME': '/home/cltbld', 05:47:02 INFO - 'LANG': 'en_US.UTF-8', 05:47:02 INFO - 'LANGUAGE': 'en_US:en', 05:47:02 INFO - 'LOGNAME': 'cltbld', 05:47:02 INFO - 'MAIL': '/var/mail/cltbld', 05:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:02 INFO - 'MOZ_NO_REMOTE': '1', 05:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:02 INFO - 'NO_EM_RESTART': '1', 05:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:02 INFO - 'PWD': '/builds/slave/test', 05:47:02 INFO - 'SHELL': '/bin/bash', 05:47:02 INFO - 'SHLVL': '1', 05:47:02 INFO - 'TERM': 'linux', 05:47:02 INFO - 'TMOUT': '86400', 05:47:02 INFO - 'USER': 'cltbld', 05:47:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:02 INFO - '_': '/tools/buildbot/bin/python'} 05:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:02 INFO - Running setup.py (path:/tmp/pip-7nh8YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:02 INFO - Running setup.py (path:/tmp/pip-TbxPUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:02 INFO - Running setup.py (path:/tmp/pip-o9H6py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:02 INFO - Running setup.py (path:/tmp/pip-dslylc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:03 INFO - Running setup.py (path:/tmp/pip-5ZGhST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:03 INFO - Running setup.py (path:/tmp/pip-iYbLe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:03 INFO - Running setup.py (path:/tmp/pip-DG4rJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:03 INFO - Running setup.py (path:/tmp/pip-3GIri0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:03 INFO - Running setup.py (path:/tmp/pip-BLxwEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:03 INFO - Running setup.py (path:/tmp/pip-BTYbG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:03 INFO - Running setup.py (path:/tmp/pip-LG3niE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:03 INFO - Running setup.py (path:/tmp/pip-z3KvTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:03 INFO - Running setup.py (path:/tmp/pip-iSCLbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:03 INFO - Running setup.py (path:/tmp/pip-AZvCRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:03 INFO - Running setup.py (path:/tmp/pip-KFM0qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:03 INFO - Running setup.py (path:/tmp/pip-XmMRrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:03 INFO - Running setup.py (path:/tmp/pip-vpfT2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:03 INFO - Running setup.py install for manifestparser 05:47:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Running setup.py install for mozcrash 05:47:04 INFO - Running setup.py install for mozdebug 05:47:04 INFO - Running setup.py install for mozdevice 05:47:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Running setup.py install for mozfile 05:47:04 INFO - Running setup.py install for mozhttpd 05:47:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Running setup.py install for mozinfo 05:47:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Running setup.py install for mozInstall 05:47:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Running setup.py install for mozleak 05:47:04 INFO - Running setup.py install for mozlog 05:47:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:04 INFO - Running setup.py install for moznetwork 05:47:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:05 INFO - Running setup.py install for mozprocess 05:47:05 INFO - Running setup.py install for mozprofile 05:47:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:05 INFO - Running setup.py install for mozrunner 05:47:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:05 INFO - Running setup.py install for mozscreenshot 05:47:05 INFO - Running setup.py install for moztest 05:47:05 INFO - Running setup.py install for mozversion 05:47:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:05 INFO - Cleaning up... 05:47:05 INFO - Return code: 0 05:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:05 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:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:05 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:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:05 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:47:05 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:47:05 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:47:05 INFO - Using env: {'DISPLAY': ':0', 05:47:05 INFO - 'HOME': '/home/cltbld', 05:47:05 INFO - 'LANG': 'en_US.UTF-8', 05:47:05 INFO - 'LANGUAGE': 'en_US:en', 05:47:05 INFO - 'LOGNAME': 'cltbld', 05:47:05 INFO - 'MAIL': '/var/mail/cltbld', 05:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:05 INFO - 'MOZ_NO_REMOTE': '1', 05:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:05 INFO - 'NO_EM_RESTART': '1', 05:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:05 INFO - 'PWD': '/builds/slave/test', 05:47:05 INFO - 'SHELL': '/bin/bash', 05:47:05 INFO - 'SHLVL': '1', 05:47:05 INFO - 'TERM': 'linux', 05:47:05 INFO - 'TMOUT': '86400', 05:47:05 INFO - 'USER': 'cltbld', 05:47:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:05 INFO - '_': '/tools/buildbot/bin/python'} 05:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:05 INFO - Running setup.py (path:/tmp/pip-mtncVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:06 INFO - Running setup.py (path:/tmp/pip-cPBjex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:06 INFO - Running setup.py (path:/tmp/pip-_YbcJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:06 INFO - Running setup.py (path:/tmp/pip-pQkXEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:06 INFO - Running setup.py (path:/tmp/pip-MmwzTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:06 INFO - Running setup.py (path:/tmp/pip-fLRPGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:06 INFO - Running setup.py (path:/tmp/pip-TYLqZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:06 INFO - Running setup.py (path:/tmp/pip-3ap_GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:06 INFO - Running setup.py (path:/tmp/pip-_MwRNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:06 INFO - Running setup.py (path:/tmp/pip-nWB1vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:06 INFO - Running setup.py (path:/tmp/pip-IrYbej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:06 INFO - Running setup.py (path:/tmp/pip-HLXznb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:06 INFO - Running setup.py (path:/tmp/pip-vnGaL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:06 INFO - Running setup.py (path:/tmp/pip-nR1lWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:06 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:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:06 INFO - Running setup.py (path:/tmp/pip-zNY95B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:07 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:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:07 INFO - Running setup.py (path:/tmp/pip-MOT6cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:07 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:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:07 INFO - Running setup.py (path:/tmp/pip-jTgFfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:09 INFO - Downloading blessings-1.6.tar.gz 05:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:09 INFO - Installing collected packages: blessings 05:47:09 INFO - Running setup.py install for blessings 05:47:09 INFO - Successfully installed blessings 05:47:09 INFO - Cleaning up... 05:47:09 INFO - Return code: 0 05:47:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:09 INFO - Reading from file tmpfile_stdout 05:47:09 INFO - Current package versions: 05:47:09 INFO - argparse == 1.2.1 05:47:09 INFO - blessings == 1.6 05:47:09 INFO - blobuploader == 1.2.4 05:47:09 INFO - docopt == 0.6.1 05:47:09 INFO - manifestparser == 1.1 05:47:09 INFO - mozInstall == 1.12 05:47:09 INFO - mozcrash == 0.17 05:47:09 INFO - mozdebug == 0.1 05:47:09 INFO - mozdevice == 0.48 05:47:09 INFO - mozfile == 1.2 05:47:09 INFO - mozhttpd == 0.7 05:47:09 INFO - mozinfo == 0.9 05:47:09 INFO - mozleak == 0.1 05:47:09 INFO - mozlog == 3.1 05:47:09 INFO - moznetwork == 0.27 05:47:09 INFO - mozprocess == 0.22 05:47:09 INFO - mozprofile == 0.28 05:47:09 INFO - mozrunner == 6.11 05:47:09 INFO - mozscreenshot == 0.1 05:47:09 INFO - mozsystemmonitor == 0.0 05:47:09 INFO - moztest == 0.7 05:47:09 INFO - mozversion == 1.4 05:47:09 INFO - psutil == 3.1.1 05:47:09 INFO - requests == 1.2.3 05:47:09 INFO - wsgiref == 0.1.2 05:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:09 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:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:09 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:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:09 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:47:09 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:47:09 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:47:09 INFO - Using env: {'DISPLAY': ':0', 05:47:09 INFO - 'HOME': '/home/cltbld', 05:47:09 INFO - 'LANG': 'en_US.UTF-8', 05:47:09 INFO - 'LANGUAGE': 'en_US:en', 05:47:09 INFO - 'LOGNAME': 'cltbld', 05:47:09 INFO - 'MAIL': '/var/mail/cltbld', 05:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:09 INFO - 'MOZ_NO_REMOTE': '1', 05:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:09 INFO - 'NO_EM_RESTART': '1', 05:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:09 INFO - 'PWD': '/builds/slave/test', 05:47:09 INFO - 'SHELL': '/bin/bash', 05:47:09 INFO - 'SHLVL': '1', 05:47:09 INFO - 'TERM': 'linux', 05:47:09 INFO - 'TMOUT': '86400', 05:47:09 INFO - 'USER': 'cltbld', 05:47:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:09 INFO - '_': '/tools/buildbot/bin/python'} 05:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 INFO - Cleaning up... 05:47:09 INFO - Return code: 0 05:47:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47:09 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:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:09 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:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:09 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:47:09 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:47:09 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:47:09 INFO - Using env: {'DISPLAY': ':0', 05:47:09 INFO - 'HOME': '/home/cltbld', 05:47:09 INFO - 'LANG': 'en_US.UTF-8', 05:47:09 INFO - 'LANGUAGE': 'en_US:en', 05:47:09 INFO - 'LOGNAME': 'cltbld', 05:47:09 INFO - 'MAIL': '/var/mail/cltbld', 05:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:09 INFO - 'MOZ_NO_REMOTE': '1', 05:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:09 INFO - 'NO_EM_RESTART': '1', 05:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:09 INFO - 'PWD': '/builds/slave/test', 05:47:09 INFO - 'SHELL': '/bin/bash', 05:47:09 INFO - 'SHLVL': '1', 05:47:09 INFO - 'TERM': 'linux', 05:47:09 INFO - 'TMOUT': '86400', 05:47:09 INFO - 'USER': 'cltbld', 05:47:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:09 INFO - '_': '/tools/buildbot/bin/python'} 05:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:09 INFO - Downloading/unpacking jsonschema 05:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:11 INFO - Downloading/unpacking functools32 (from jsonschema) 05:47:11 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:47:11 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:47:11 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:47:11 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:47:11 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:47:11 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:47:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:12 INFO - warning: no files found matching '*.txt' 05:47:12 INFO - no previously-included directories found matching 'build' 05:47:12 INFO - no previously-included directories found matching 'dist' 05:47:12 INFO - no previously-included directories found matching '.git*' 05:47:12 INFO - Installing collected packages: jsonschema, functools32 05:47:12 INFO - Running setup.py install for functools32 05:47:12 INFO - warning: no files found matching '*.txt' 05:47:12 INFO - no previously-included directories found matching 'build' 05:47:12 INFO - no previously-included directories found matching 'dist' 05:47:12 INFO - no previously-included directories found matching '.git*' 05:47:12 INFO - Successfully installed jsonschema functools32 05:47:12 INFO - Cleaning up... 05:47:12 INFO - Return code: 0 05:47:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:12 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 0x7f163f820f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', '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:47:12 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:47:12 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:47:12 INFO - Using env: {'DISPLAY': ':0', 05:47:12 INFO - 'HOME': '/home/cltbld', 05:47:12 INFO - 'LANG': 'en_US.UTF-8', 05:47:12 INFO - 'LANGUAGE': 'en_US:en', 05:47:12 INFO - 'LOGNAME': 'cltbld', 05:47:12 INFO - 'MAIL': '/var/mail/cltbld', 05:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:12 INFO - 'MOZ_NO_REMOTE': '1', 05:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:12 INFO - 'NO_EM_RESTART': '1', 05:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:12 INFO - 'PWD': '/builds/slave/test', 05:47:12 INFO - 'SHELL': '/bin/bash', 05:47:12 INFO - 'SHLVL': '1', 05:47:12 INFO - 'TERM': 'linux', 05:47:12 INFO - 'TMOUT': '86400', 05:47:12 INFO - 'USER': 'cltbld', 05:47:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:12 INFO - '_': '/tools/buildbot/bin/python'} 05:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:12 INFO - Downloading/unpacking flake8 05:47:12 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:47:12 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:47:12 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:47:12 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:47:12 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:47:12 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:47:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:47:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:47:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:47:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:47:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:47:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:47:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:47:15 INFO - no previously-included directories found matching 'docs/_build' 05:47:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:47:15 INFO - Running setup.py install for pep8 05:47:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:47:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:47:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:47:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:47:15 INFO - no previously-included directories found matching 'docs/_build' 05:47:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:47:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:47:15 INFO - Cleaning up... 05:47:15 INFO - Return code: 0 05:47:15 INFO - Running post-action listener: _resource_record_post_action 05:47:15 INFO - Running post-action listener: _start_resource_monitoring 05:47:15 INFO - Starting resource monitoring. 05:47:15 INFO - ##### 05:47:15 INFO - ##### Running install step. 05:47:15 INFO - ##### 05:47:15 INFO - Running pre-action listener: _resource_record_pre_action 05:47:15 INFO - Running main action method: install 05:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:15 INFO - Reading from file tmpfile_stdout 05:47:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:47:15 INFO - Reading from file tmpfile_stdout 05:47:15 INFO - Output received: 05:47:15 INFO - Usage: mozinstall [options] installer 05:47:15 INFO - Options: 05:47:15 INFO - -h, --help show this help message and exit 05:47:15 INFO - -d DEST, --destination=DEST 05:47:15 INFO - Directory to install application into. [default: 05:47:15 INFO - "/builds/slave/test"] 05:47:15 INFO - --app=APP Application being installed. [default: firefox] 05:47:15 INFO - mkdir: /builds/slave/test/build/application 05:47:15 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:47:15 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:47:32 INFO - Reading from file tmpfile_stdout 05:47:32 INFO - Output received: 05:47:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:47:32 INFO - Running post-action listener: _resource_record_post_action 05:47:32 INFO - ##### 05:47:32 INFO - ##### Running run-tests step. 05:47:32 INFO - ##### 05:47:32 INFO - Running pre-action listener: _resource_record_pre_action 05:47:32 INFO - Running main action method: run_tests 05:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:32 INFO - Python 2.7.3 05:47:32 INFO - Return code: 0 05:47:32 INFO - grabbing minidump binary from tooltool 05:47:32 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:47:32 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 0x2a31410>, '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 0x2a32310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a327a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:32 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:47:32 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:47:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:32 INFO - Return code: 0 05:47:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:47:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:47:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:47:33 INFO - Return code: 0 05:47:33 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/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:47:33 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/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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:47:33 INFO - Using env: {'DISPLAY': ':0', 05:47:33 INFO - 'HOME': '/home/cltbld', 05:47:33 INFO - 'LANG': 'en_US.UTF-8', 05:47:33 INFO - 'LANGUAGE': 'en_US:en', 05:47:33 INFO - 'LOGNAME': 'cltbld', 05:47:33 INFO - 'MAIL': '/var/mail/cltbld', 05:47:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:33 INFO - 'MOZ_NO_REMOTE': '1', 05:47:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:33 INFO - 'NO_EM_RESTART': '1', 05:47:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:33 INFO - 'PWD': '/builds/slave/test', 05:47:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:33 INFO - 'SHELL': '/bin/bash', 05:47:33 INFO - 'SHLVL': '1', 05:47:33 INFO - 'TERM': 'linux', 05:47:33 INFO - 'TMOUT': '86400', 05:47:33 INFO - 'USER': 'cltbld', 05:47:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409', 05:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:33 INFO - '_': '/tools/buildbot/bin/python'} 05:47:33 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/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:47:33 INFO - mozversion application_buildid: 20160420030213 05:47:33 INFO - mozversion application_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 05:47:33 INFO - mozversion application_display_name: Nightly 05:47:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:33 INFO - mozversion application_name: Firefox 05:47:33 INFO - mozversion application_remotingname: firefox 05:47:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:33 INFO - mozversion application_vendor: Mozilla 05:47:33 INFO - mozversion application_version: 48.0a1 05:47:33 INFO - mozversion platform_buildid: 20160420030213 05:47:33 INFO - mozversion platform_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 05:47:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:33 INFO - mozversion platform_version: 48.0a1 05:47:33 INFO - using testdate: 1461156453 05:47:33 INFO - actual date: 1461156453 05:47:33 INFO - starting webserver on 'localhost:36107' 05:47:33 INFO - SUITE-START | Running 2 tests 05:47:33 INFO - TEST-START | dromaeo_css 05:47:33 INFO - operating with platform_type : linux_ 05:47:33 INFO - Initialising browser for dromaeo_css test... 05:47:33 INFO - TEST-INFO | started process 4470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdYrBx/profile http://localhost:36107/getInfo.html) 05:47:37 INFO - PROCESS | 4470 | 05:47:37 INFO - PROCESS | 4470 | (process:4539): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:47:38 INFO - PROCESS | 4470 | __metrics Screen width/height:1600/1200 05:47:38 INFO - PROCESS | 4470 | colorDepth:24 05:47:38 INFO - PROCESS | 4470 | Browser inner width/height: 1024/697 05:47:38 INFO - PROCESS | 4470 | __metrics 05:47:38 ERROR - PROCESS | 4470 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:47:39 INFO - TEST-INFO | 4470: exit 0 05:47:39 INFO - Browser initialized. 05:47:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:39 INFO - TEST-INFO | started process 4590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdYrBx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:41 INFO - PROCESS | 4590 | 05:47:41 INFO - PROCESS | 4590 | (process:4649): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:47:51 INFO - PROCESS | 4590 | RSS: Main: 163328000 05:47:51 INFO - PROCESS | 4590 | 05:48:41 INFO - PROCESS | 4590 | 1461156521078 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:50:48 INFO - PROCESS | 4590 | Cycle 1(1): loaded http://localhost:36107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36107/tests/dromaeo/cssquery-ext.html) 05:50:49 INFO - PROCESS | 4590 | RSS: Main: 168669184 05:50:49 INFO - PROCESS | 4590 | 05:53:51 INFO - PROCESS | 4590 | Cycle 1(1): loaded http://localhost:36107/tests/dromaeo/cssquery-ext.html (next: http://localhost:36107/tests/dromaeo/cssquery-jquery.html) 05:53:52 INFO - PROCESS | 4590 | RSS: Main: 165617664 05:53:52 INFO - PROCESS | 4590 | 05:56:54 INFO - PROCESS | 4590 | Cycle 1(1): loaded http://localhost:36107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36107/tests/dromaeo/cssquery-mootools.html) 05:56:54 INFO - PROCESS | 4590 | RSS: Main: 166785024 05:56:54 INFO - PROCESS | 4590 | 05:59:56 INFO - PROCESS | 4590 | Cycle 1(1): loaded http://localhost:36107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36107/tests/dromaeo/cssquery-prototype.html) 05:59:57 INFO - PROCESS | 4590 | RSS: Main: 164634624 05:59:57 INFO - PROCESS | 4590 | 06:02:59 INFO - PROCESS | 4590 | Cycle 1(1): loaded http://localhost:36107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36107/tests/dromaeo/cssquery-yui.html) 06:03:00 INFO - PROCESS | 4590 | RSS: Main: 165380096 06:03:00 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | Cycle 1(1): loaded http://localhost:36107/tests/dromaeo/cssquery-yui.html (next: http://localhost:36107/tests/dromaeo/cssquery-dojo.html) 06:06:02 INFO - PROCESS | 4590 | RSS: Main: 167776256 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | __start_tp_report 06:06:02 INFO - PROCESS | 4590 | _x_x_mozilla_page_load 06:06:02 INFO - PROCESS | 4590 | _x_x_mozilla_page_load_details 06:06:02 INFO - PROCESS | 4590 | |i|pagename|runs| 06:06:02 INFO - PROCESS | 4590 | |0;dojo.html;3168.6672899345567;3196.6963138501847;3221.0497903118576;3260.918477038074;3262.5269335946286;5529.447055294469;5530.308711411074;5560.7219639018085;5566.888662226758;5568.638038527492;5440.945590544094;5582.91625625615;5615.522680572146;5624.91562626561;5723.456271654186;4982;5014.047331007116;5107.693538387709;5112.437631860493;5137.743112844361;808.5185025902581;4894.975525122387;4929.383827021622;4955.256711493269;5025.145725226702;4977.776000080005;4989.426215985171;4995.600351971833;5004.274380214867;5012.298278241049;5026.497350264981;5032.3961124665275;5036.06832735945;5040.949590504085;5049.267856160836;4865.343178670905;4949.381327334083;4975.402951645826;5024.397072351341;5046.26829109777;5440.401555828856;5470.863228419282;5488.725563721798;5510.8071217507195;5511.283533140706;5838.824835254949;5976.551758618121;6011.617328014538;6018.4583387494895;6032.969835150796;5959.433853783884;6036.909446358308;6057.939420605781;6086.573939824214;6108.144859719643;5536.584756143306;5540.778368865241;5546.473085056913;5559.388467268637;5561.221428999943;5900.350961394243;6035.064564992434;6042.365551617105;6078.300995385499;6088.51291896656;5879.176915231871;5887.793927212612;5893.351731309553;5897.911531327033;5928.584999050111;5912.054071348563;5937.168796368512;5941.346451890288;5945.870284645904;5988.730507127189;5785.190073389729;5873.618214816023;5911.4975227105315;5922.2597175353085;5976.223090998143;5864.354920958691;5899.233099697012;5935.554833387427;5956.52347812174;5961.731722072517;4463.085067561142;4468.329750537446;4472.44094488189;4480.14877173336;4530.433695788027;3904.472896159039;3937.5078115235597;3972.1261322509004;3994.141259629194;4030.8186131624147;5572.944270557324;5603.075492543685;5614.101743720985;5688.488036076773;5705.115707065412;5943.049112142036;5983.102534619842;5987.9101813472835;6017.729202185912;6019.337872833985;5573.832785016456;5583.246261754693;5648.689322087324;5675.858103547444;5709.942900571024;5074.492550744896;5128.538431541179;5145;5148.485151484896;5157.149070403341;6187.443130118311;6202.81391558254;6206.379362063757;6230.376962303733;6235.937640623626;5856.9999999999145;5892.35184129754;5966.910496342645;5967;5974.253218347707;6118.464955528275;6227.408396202353;6234.15838861766;6246.344133865879;6257.8748425030335;5914.615549989237;5920.496757775637;5937.584369094122;5946.345901950868;5982.282126144891;5835.56233282514;6022.397760223943;6029.246344206974;6034.69826508664;6037.486813620716;5862.853428664317;5863.472287494146;5863.648181109147;5865.824025279248;5915.438033386821;5749.798757043483;5759.452851979056;5846.970765146317;5852.7658893643775;5875.177475153568;5677.318721753416;5731.971340143439;5755.827325180251;5781.075027995501;5820.854478637899;5798.913016304675;5844.12338149281;5865.706714664335;5878.823635290948;5900.734466949083;5750.597458177887;5755.8561035974435;5773.826785196451;5775.7400916957995;5781.884362312646 06:06:02 INFO - PROCESS | 4590 | |1;ext.html;584.5265335078586;649.2760571962262;659.7229163751224;671.6507416143605;673.2795908378038;37255.441168382466;38015.42976855346;38383.61616383836;38734;38738.8063059685;42284.78857605715;43014.569854301444;43207.783961080226;43261.78369108158;43336;8716;8916.331275154389;8917;8919.28645708345;8932.240759535447;8645.265152462049;8722.86915696265;8751.3436492263;8798.6920457784;8808.691695790649;8728;8829.690960816373;8849.95575022124;8863.734087977371;8878.46729196247;8733.868991965126;8760.8685869712;8802.251808596277;8829.16122968317;8829.161229683203;8780.956095219546;8882.15619516145;8886.555672216427;8887.955560222223;8890.777730556723;40955.795221023705;41057.38413923793;41104.38343424851;41212.79393603043;41276.793616031726;3451.8274086295582;3536.522569453117;3571.4642803579413;3642.7996460194677;4152.771597562133;29965.25086872824;30152.396952061055;30429.239269018453;30531.847340763154;30537;4169.958300416987;4202.936955945664;4314.848980285675;4378.102488989782;4422.270325396305;243307;250554;252593;252837;254419.99999999814;36824.81587592045;37754.8112259437;37843.81078094592;64073;64745.35254647393;36609.26781464356;36681.63318366835;36802.81598592043;36947;36999.075023124635;14370.568882933529;14502.85497145036;14600.196989165486;14618.488352907598;14667.706645867023;12106.394680265952;12321.568745093879;12359.073069519822;12364.44360003802;12389.442475088463;8809.779755506164;8838.381313308135;8868.423552469068;8873.334499912533;8898.288136949028;3370.7303415726683;3429;3439.518467414564;3443.7933723976644;3511.754177207622;1026.9897301027042;1027.2141811514198;1080.2600218850114;1100.2848148703406;1148.8851114888444;31800.84099579487;32198.517022244687;32414.67585324164;32471.837640811646;32560;1095.912327013837;1109.5839060352369;1112.0603090388609;1128.9717757055976;1186.163754553038;16858.24137913797;17258.82741172597;17804.198811053535;17914.731279030824;18032.909835451002;343022;344704;348106;348649;348670;58178;59407.702961484916;59542;59706.10440843391;59736;1324.2120938041849;1335.5226055666988;1350.108928107464;1352.6753579140936;1355.9322033898463;32233.194170145933;32623.510647340783;32947;32972.67027329696;32997.17507062342;51621.22568161556;51865.48134518607;52411.73794131158;52449.21326180034;52496;428406;429368;432132;433906;435915;28771.712282876902;29093.7090629091;29218.269543261587;29547.85226073856;29630.111096667133;46896.29655555238;47283.29075063808;48293.275600865316;49034.50965490299;49693.25460118029;40145.1970960585;41068.38397423981;42312.36531451969;42726;42920;39988.20878445577;41411.7929410351;41487.377689335284;41491;42043.1591368177;41179.58820411757;41735.165296694504;41775.7911210442;42041.15917681568;42972.78513607412;35968.460473093444;36945.07637309089;37022.81488592648;37503.249935000604;37538.436923446716;27917.302067447665;28057.897248289766;28269.39929891641;28378.2905427366;28407.147785566467 06:06:02 INFO - PROCESS | 4590 | |2;jquery.html;384.73837790302616;386.7795356646712;393.43934892777787;399.38846753350236;400.0618549501418;14635.19506427146;17872.37446689366;17912.910435447822;18507.907460462695;18655.067246637664;16219.432319868778;16894.662106757856;17014;17015.659686806255;17168.82831171688;5657.038303488417;5710.543156547487;5741.19623252745;5850.151727999438;5887.0286402743495;5721.170430287606;5754.1944127822135;5768.451997060272;5810.15752715856;5825.708714564276;5546.722663866811;5776.480116789488;5783.421657834225;5823.475887170154;5825.796097136601;5711.685857277848;5731.484166425;5731.942680573183;5743.885122297531;5810.477057064863;4953.455119936804;5165.845024649267;5170.1986192140275;5170.534651881311;5181.948180518184;21936.89031554832;22420.215292464847;22813.429664258525;22995.77004229953;23009.654855177185;2044.826189773871;2099.191811152702;2141.0472339808794;2290.690756747851;2297.287840769367;14066.71866562663;14351.138931664029;14525.564233073024;14562.199079050648;14653.853461465356;1958.128632758423;2046.7441569803775;2059.588082383529;2060.258307009475;2066.2664754012258;81210;81241.18758812395;81590.59204703939;81780.59109704413;82178;10037.648682296085;10178.23663225261;10556.63051793199;10569.947150264199;10784.94607526973;13037.478500860048;13703.657408564666;14716.77924831107;14829.40682372693;14833.184174870486;7802.570858602831;7930.1276859545405;8153.714619988391;8356.540390278471;8409.075001749803;8060.758177254692;8089.150639182919;8103.392245581605;8227.465214761021;8230.670773169126;6373.745050198033;6566.080748695186;6644.202695676549;6662.400383965466;6680.732770689216;1843.8340549350623;1897.5066482714594;1906.447130332216;1912.6174765046767;1945.8443324534287;910.3081657940013;998.7752755630071;1071.2287153249647;1076.7738774857212;1115.525139191413;18886.3389781357;19622.411327660193;19640;19731.802681972997;19844.50388740293;1012.4684540616088;1025.553884060436;1035.2649618770756;1048.3238311289176;1071.4160782373624;10863.67408977732;11147.888521114684;11156.832647510293;11184;11199.160062995144;374856;383177;458297;459005;462786;84575.15424845673;91588;95959;95977;98361;1036.5439206749006;1038.4029183219527;1069.6202847989007;1103.6799328194895;1115.7043383503378;16269.59326016859;16277.267522961258;16290.10404427768;16507.9174604131;16559.751603725712;28014.579781302888;38191.80904095462;39506.60493395144;39971.40042899301;39980.80009599934;51256.48743512517;52685;53183.46816531785;53430.4656953441;54020;8474;8477.15228477172;8577;8639.308855291436;8996.955015224881;8997;12273.815892761795;13109.213447193199;13261.867381326063;13487.730245395234;11257.21199516026;11389.259698119597;11424.428778560872;11710.531578736754;11792.916074677765;11554.537818487503;11693.532258709556;11778.823317650413;11784.646460606196;11890.702732431759;11436.37099959477;11603.477843497232;11711.941440293085;12004.699882503008;12147.635570932885;7307.086614173229;7646.617669116633;7693.692252309845;8036.397270204641;8544.316454683734;10899.509522071367;11253.847650501288;11324.32054076758;11508.53965841357;11871.940640296743 06:06:02 INFO - PROCESS | 4590 | |3;mootools.html;1476.1954734669607;1477.3647331647392;1652.4051341517052;1689.6029433083215;1796.8562514998794;7459.291367320109;7864.095629002666;7964.601769911503;8338.541380224093;8359.874601880969;7949.165337639552;7954.522728636286;7970.442069055154;7992;8054.275115239628;2216.601011817872;2254.4363909022786;2267.0591704442636;2268.1947908492493;2270.0465804362207;2175.358269310549;2175.3800166952424;2215.2025270902463;2221.511267521151;2244.0350649220827;2244.618414869468;2255.796978271955;2257.142285931352;2279.521300526883;2304.8617082974993;2173.89130543473;2174.6085704573093;2175.5105101352146;2182.71624688791;2184.945376365588;2212.760853921809;2225.7662945390825;2225.844190906621;2227.9331620051425;2229.4203507088273;8045.195480451966;8046.919530804676;8049.195080491904;8053.677852885936;8080.353571714249;4964.702117872939;5099.821506247301;5127.641065125443;5182.611304152166;5188.533032027136;3124.4844600640868;3235.902922912316;3291.0620473165272;3320.9833950830334;3368.4105281575626;1139.2082502660653;1143.9599614013553;1180.4982882274999;1193.2721040165493;1204.7289359894041;11383.601573944872;11384.430778461126;11474.082073434105;11509.942450287695;11516.25144365622;4381.430414046217;4395.099004704028;4517.909641807146;4544.954550454519;4562.657800664963;9740.074692904305;9746.756331091638;9776.826780786208;9787.85318220213;9800.26498012652;5141.177411614124;5147.6654017488745;5151.948480515147;5167.870803229949;5207.270982062514;4007.6593489553716;4616.238320677118;4666.603338716247;4722.055588882237;4750.382450281441;3842.135519508144;3848.7113466490127;3926.293267211929;3944.073142811437;3955.0705584187695;1242.031215651793;1254.8933340665963;1263.0842639086588;1267.2206592945456;1269.993650031744;919.6873063158424;935.3639525122845;946.6592026870321;963.9951800240954;1007.2596641468515;5559.77760889568;5666.263385759825;5678.0915053591225;5781.479666829921;5802.013657678205;422.96404805591254;425.4044337926927;428.75775187019235;430.476970480861;437.61271274921285;3818.6181381862148;3862.517185351831;3864.3623802072907;3873.6320049595242;3934.3705007199283;9799.118079372749;10208.591656333663;10258.43578603184;10281.434521101412;10311.22665800068;9570.90429095714;9881.901180988241;9960.501974901226;10015.899841001497;10154.492275386348;7573.091229052549;7639.197884222188;7655.57894315818;7736.535807851435;7810.45326827128;5300.337457817773;5351.866203344947;5415.160650099241;5423.240746295601;5479.863003424946;8397.538135402612;8581.141885811368;8611.65553377858;8633.525156116473;8729.170728780755;8635.870461943201;8656.91343086561;8728.519931403835;8823.073577274294;9111.681091161778;6596.736130554724;7231.927680723125;7325.853482930418;7406.185319614946;7475.43934204926;7940.483868548526;7993.4804237726685;8033.236842499953;8091.474054186459;8097.554634494923;7030.543014704028;7151.892721609076;7240.782776516713;7295.890561641686;7304.744333948286;7066.964665176642;7089.361957423856;7155.892661610184;7192.100987376578;7306;6132.47873930703;6311.621302721851;6315.778947736807;6316;6347.333529979285;4668.953310466852;4717.2216584263215;4718.268668356411;4724.503927087606;4767.284907263938;4706.929396058993;4758.31004504338;4768.57082862544;4810.11012962603;4811.470738218723 06:06:02 INFO - PROCESS | 4590 | |4;prototype.html;317.5776217630551;319.6627557926388;323.06794896722954;323.4291475545662;330.3525090821989;5943.554233432488;6088.969555152229;6106.419890110438;6131.202943617329;6156.322804491502;5969.194158788562;5986;6016.826718789837;6018.15745795589;6045.848853778647;4302.698811083217;4387.62705170061;4529.547045295477;4536.682432229745;4547.681662283641;4512.819487220508;4538.069695712387;4539.205639013159;4571.222892108333;4576.771161441931;4515.683902126836;4534.841280555182;4541.114482675879;4562.224421848277;4573.010740327952;4378.62781663559;4523.570260825217;4530.456345238559;4534.750588717619;4535.115652447774;3965.543962444327;3976.363781794928;3988.720789544733;3988.9800550997347;3993.5806740292433;5785.566082543826;5788.942110578924;5801.9129713054335;5806.680632565207;5814.883702325972;5147.948520514784;5286.867828304323;5293.75596734767;5308.601854860901;5319.654222475527;6254.655993920333;6275.623462592259;6294.087357333161;6327.936720632781;6351.920173570504;4275.572442755731;4421.756803375813;4424.756638384888;4427.2695005324085;4428;6555.147830782015;6580.585174187525;6621.801345959629;6652.434543063845;6655.401013908771;4527.185106680829;4528.818847246073;4565.109803588335;4566.223741963874;4575.725456472623;4250.957490425118;4496.055828276033;4628.166929952574;4643.582077613031;4644.140833945663;5226.163813789852;5229.686218826882;5230.378582639394;5234.398044224887;5260.526552610207;6427;6427.421532062043;6438.356164383524;6451.612903225821;6464.806055818333;1575.1021917506912;1601.7036848183122;1617.3288085444644;1619.1337634365557;1621.1407953784512;1056.6143357674548;1064.095518809006;1083.7994970930404;1083.8970297821695;1092.2408925796494;6142.3550527194;6150.630962142286;6159.81520554384;6164.907526387108;6181.289151747516;6369.5222858285815;6502.642354670538;6548.901766473411;6560.44236239925;6560.737570497126;6063.6664983426335;6113.877722445526;6124.448799608057;6138.7237574309265;6146.200993870768;3473.2879759649213;3487.616362200156;3498.930021399558;3501.2647344057523;3522.682958533744;6543.44380727634;6666.866662666719;6726.284797376736;6778;6802.14973128359;6556.770513032021;6609.537332386687;6617.2059352877;6627;6682.799516014527;6535.379138981789;6689.866202675919;6690.59856408617;6745;6768.289329620417;6496.480281577557;6506.934930650633;6521.315261897433;6521.67391630426;6526.804195874131;6286.654234017173;6400.967995160181;6415.935840641534;6437.227532696106;6495.805125846232;6734.259231484435;6780.593164410151;6786.626735529593;6799.898001529882;6803.965980170067;4578.633709303314;4583.702059366131;4594.425696787902;4596.678232523691;4599.057193275304;6281.607931717004;6497.310699218332;6498.837529061811;6502.219733631994;6572.4084832365315;6333.240011198685;6351.587146835441;6384.07430922523;6386.074019267273;6399.360063993563;6192;6345.238571371465;6389.52078594098;6396.648184349905;6401.135846660642;6228.719707613259;6273.14942092093;6408.198975128109;6415.390537898892;6428.389303016206;6524.184476940382;6548.869022619426;6597.80206593803;6601.339866013553;6608.4382827458285;6133.601315914451;6451.1936007999;6457.223393940651;6463.095166676575;6469.118528882633 06:06:02 INFO - PROCESS | 4590 | |5;yui.html;749.3068911257086;811.8741595052761;812.9918700812991;826.6693322670931;830.4353039932847;14518.564443066713;14787.926060369684;14872.33074511647;14913.478028269026;14980.850191498082;13829.962752793555;13868.930655346734;13920.860791392082;13938.233397163152;13942.233177175276;674.740225013371;803.1486624178375;815.7634286057037;823.5017814222399;838.8993320801512;810.5987536169604;813.2436833744615;813.5647428625687;819.3404309530825;820.7660816667251;869.6390997735932;869.7086476030506;871.7210492642357;875.0549406640845;878.6397576993434;864.0452300208242;865.2947847504264;865.4590880699562;867.2195024477958;874.4927941793744;617.222299902122;621.2048577820398;626.5426238845669;627.8493161641219;630.2594451519446;14544.272786360745;14599.41602335916;14638.707225855424;14640.194789286585;14687.70624587513;14465.49370772018;14503.1298122113;14526.854731452657;14611.63470913225;14839.10965342072;11202.66392008241;11509.424528773528;11564.826527602092;11775.7056073598;11783.234089784137;3897.80510974453;3910.432987216838;3915.432262321976;3953.0710283083454;3989.4215338775716;55256;55813.72093139549;56127.71936140334;56129.71935140298;56503.15245271324;11433.428328583537;11563.306201627762;11599.666038405692;11614.6515604532;11628.592999244986;20854.687179692315;20931.68602470964;20989.89505052465;21057.262995795074;21116;8094.959525202454;8184.427090103754;8211.876821847676;8260.297874680598;8359.373047021498;4726.787294571684;4734.905301893943;4742.976285118552;4793.209120495149;5022.372203474566;3372.4941258811373;3486.6687664671817;3497.2655742293896;3506.403911335079;3511.0871173495075;654.4044919123575;657.0374401501823;683.6274230544366;711.2389742974967;714.2107970692414;654.8166513376262;690.3407246079981;745.9030326057687;759.4987308376556;774.156169774948;9209.263258939403;9706.563204655808;9715.46564938935;9874.111329980193;9997.700068997796;606.7360698096343;690.492488021304;725.4994054102652;767.075673813054;773.3619763694974;4366.170427618742;4474.798634061475;4515.254982927846;4536.500984891659;4616;54253.45746542563;55462;55959;68106.31893681;68878;53553.464465354846;53652.73173634107;54259.72870135624;54477.45522544803;56810.431895681344;37463;42066.789666052086;42630.36054459186;50382.748086260064;51014.48985510172;9264.166225039779;9618.326717129734;9674.70975870725;9763.142114731105;9820.361676491006;31453.685463145077;31878.68121318757;31983.520247195844;32354;32667.34665306728;34153.48769768505;37782.2443551133;39991;43163;44338.77830610827;12264.816027759412;12276.324802135969;12655.11414201034;12783.296918669563;12872.16330938486;13402.731945361233;13693.178409295475;13998.300084995506;14258.786118208443;14310.785338220143;13173.670658233621;13375.53185638498;13594.388252528857;13605.523806666719;14346.139231646135;12736.87263127394;12833.743325133632;13186.340682966005;13214.735705285648;13532.661683457993;13058.738825223252;13209.801852972021;13231.27228002469;13308.800367994294;13339.266340350985;11048.392338421143;11099.389533575408;11135.387553684624;11264.267822591506;11299;10672.679819605424;10819.891801081889;10858.402787846428;10866.61966831157;10891.727706807393 06:06:02 INFO - PROCESS | 4590 | __end_tp_report 06:06:02 INFO - PROCESS | 4590 | __start_cc_report 06:06:02 INFO - PROCESS | 4590 | _x_x_mozilla_cycle_collect,337 06:06:02 INFO - PROCESS | 4590 | __end_cc_report 06:06:02 INFO - PROCESS | 4590 | __startTimestamp1461157562608__endTimestamp 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | ------- Summary: start ------- 06:06:02 INFO - PROCESS | 4590 | Number of tests: 6 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | [#0] dojo.html Cycles:165 Average:5500.79 Median:5775.74 stddev:746.72 (12.9%) stddev-sans-first:726.25 06:06:02 INFO - PROCESS | 4590 | Values: 3168.7 3196.7 3221.0 3260.9 3262.5 5529.4 5530.3 5560.7 5566.9 5568.6 5440.9 5582.9 5615.5 5624.9 5723.5 4982.0 5014.0 5107.7 5112.4 5137.7 808.5 4895.0 4929.4 4955.3 5025.1 4977.8 4989.4 4995.6 5004.3 5012.3 5026.5 5032.4 5036.1 5040.9 5049.3 4865.3 4949.4 4975.4 5024.4 5046.3 5440.4 5470.9 5488.7 5510.8 5511.3 5838.8 5976.6 6011.6 6018.5 6033.0 5959.4 6036.9 6057.9 6086.6 6108.1 5536.6 5540.8 5546.5 5559.4 5561.2 5900.4 6035.1 6042.4 6078.3 6088.5 5879.2 5887.8 5893.4 5897.9 5928.6 5912.1 5937.2 5941.3 5945.9 5988.7 5785.2 5873.6 5911.5 5922.3 5976.2 5864.4 5899.2 5935.6 5956.5 5961.7 4463.1 4468.3 4472.4 4480.1 4530.4 3904.5 3937.5 3972.1 3994.1 4030.8 5572.9 5603.1 5614.1 5688.5 5705.1 5943.0 5983.1 5987.9 6017.7 6019.3 5573.8 5583.2 5648.7 5675.9 5709.9 5074.5 5128.5 5145.0 5148.5 5157.1 6187.4 6202.8 6206.4 6230.4 6235.9 5857.0 5892.4 5966.9 5967.0 5974.3 6118.5 6227.4 6234.2 6246.3 6257.9 5914.6 5920.5 5937.6 5946.3 5982.3 5835.6 6022.4 6029.2 6034.7 6037.5 5862.9 5863.5 5863.6 5865.8 5915.4 5749.8 5759.5 5847.0 5852.8 5875.2 5677.3 5732.0 5755.8 5781.1 5820.9 5798.9 5844.1 5865.7 5878.8 5900.7 5750.6 5755.9 5773.8 5775.7 5781.9 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | [#1] ext.html Cycles:180 Average:50676.43 Median:38736.40 stddev:92613.55 (239.1%) stddev-sans-first:92796.99 06:06:02 INFO - PROCESS | 4590 | Values: 584.5 649.3 659.7 671.7 673.3 37255.4 38015.4 38383.6 38734.0 38738.8 42284.8 43014.6 43207.8 43261.8 43336.0 8716.0 8916.3 8917.0 8919.3 8932.2 8645.3 8722.9 8751.3 8798.7 8808.7 8728.0 8829.7 8850.0 8863.7 8878.5 8733.9 8760.9 8802.3 8829.2 8829.2 8781.0 8882.2 8886.6 8888.0 8890.8 40955.8 41057.4 41104.4 41212.8 41276.8 3451.8 3536.5 3571.5 3642.8 4152.8 29965.3 30152.4 30429.2 30531.8 30537.0 4170.0 4202.9 4314.8 4378.1 4422.3 243307.0 250554.0 252593.0 252837.0 254420.0 36824.8 37754.8 37843.8 64073.0 64745.4 36609.3 36681.6 36802.8 36947.0 36999.1 14370.6 14502.9 14600.2 14618.5 14667.7 12106.4 12321.6 12359.1 12364.4 12389.4 8809.8 8838.4 8868.4 8873.3 8898.3 3370.7 3429.0 3439.5 3443.8 3511.8 1027.0 1027.2 1080.3 1100.3 1148.9 31800.8 32198.5 32414.7 32471.8 32560.0 1095.9 1109.6 1112.1 1129.0 1186.2 16858.2 17258.8 17804.2 17914.7 18032.9 343022.0 344704.0 348106.0 348649.0 348670.0 58178.0 59407.7 59542.0 59706.1 59736.0 1324.2 1335.5 1350.1 1352.7 1355.9 32233.2 32623.5 32947.0 32972.7 32997.2 51621.2 51865.5 52411.7 52449.2 52496.0 428406.0 429368.0 432132.0 433906.0 435915.0 28771.7 29093.7 29218.3 29547.9 29630.1 46896.3 47283.3 48293.3 49034.5 49693.3 40145.2 41068.4 42312.4 42726.0 42920.0 39988.2 41411.8 41487.4 41491.0 42043.2 41179.6 41735.2 41775.8 42041.2 42972.8 35968.5 36945.1 37022.8 37503.2 37538.4 27917.3 28057.9 28269.4 28378.3 28407.1 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | [#2] jquery.html Cycles:180 Average:26985.84 Median:22178.55 stddev:71182.20 (321.0%) stddev-sans-first:71353.87 06:06:02 INFO - PROCESS | 4590 | Values: 384.7 386.8 393.4 399.4 400.1 14635.2 17872.4 17912.9 18507.9 18655.1 16219.4 16894.7 17014.0 17015.7 17168.8 5657.0 5710.5 5741.2 5850.2 5887.0 5721.2 5754.2 5768.5 5810.2 5825.7 5546.7 5776.5 5783.4 5823.5 5825.8 5711.7 5731.5 5731.9 5743.9 5810.5 4953.5 5165.8 5170.2 5170.5 5181.9 21936.9 22420.2 22813.4 22995.8 23009.7 2044.8 2099.2 2141.0 2290.7 2297.3 14066.7 14351.1 14525.6 14562.2 14653.9 1958.1 2046.7 2059.6 2060.3 2066.3 81210.0 81241.2 81590.6 81780.6 82178.0 10037.6 10178.2 10556.6 10569.9 10784.9 13037.5 13703.7 14716.8 14829.4 14833.2 7802.6 7930.1 8153.7 8356.5 8409.1 8060.8 8089.2 8103.4 8227.5 8230.7 6373.7 6566.1 6644.2 6662.4 6680.7 1843.8 1897.5 1906.4 1912.6 1945.8 910.3 998.8 1071.2 1076.8 1115.5 18886.3 19622.4 19640.0 19731.8 19844.5 1012.5 1025.6 1035.3 1048.3 1071.4 10863.7 11147.9 11156.8 11184.0 11199.2 374856.0 383177.0 458297.0 459005.0 462786.0 84575.2 91588.0 95959.0 95977.0 98361.0 1036.5 1038.4 1069.6 1103.7 1115.7 16269.6 16277.3 16290.1 16507.9 16559.8 28014.6 38191.8 39506.6 39971.4 39980.8 51256.5 52685.0 53183.5 53430.5 54020.0 8474.0 8477.2 8577.0 8639.3 8997.0 8997.0 12273.8 13109.2 13261.9 13487.7 11257.2 11389.3 11424.4 11710.5 11792.9 11554.5 11693.5 11778.8 11784.6 11890.7 11436.4 11603.5 11711.9 12004.7 12147.6 7307.1 7646.6 7693.7 8036.4 8544.3 10899.5 11253.8 11324.3 11508.5 11871.9 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | [#3] mootools.html Cycles:180 Average:5383.42 Median:4810.79 stddev:2989.87 (62.1%) stddev-sans-first:2983.84 06:06:02 INFO - PROCESS | 4590 | Values: 1476.2 1477.4 1652.4 1689.6 1796.9 7459.3 7864.1 7964.6 8338.5 8359.9 7949.2 7954.5 7970.4 7992.0 8054.3 2216.6 2254.4 2267.1 2268.2 2270.0 2175.4 2175.4 2215.2 2221.5 2244.0 2244.6 2255.8 2257.1 2279.5 2304.9 2173.9 2174.6 2175.5 2182.7 2184.9 2212.8 2225.8 2225.8 2227.9 2229.4 8045.2 8046.9 8049.2 8053.7 8080.4 4964.7 5099.8 5127.6 5182.6 5188.5 3124.5 3235.9 3291.1 3321.0 3368.4 1139.2 1144.0 1180.5 1193.3 1204.7 11383.6 11384.4 11474.1 11509.9 11516.3 4381.4 4395.1 4517.9 4545.0 4562.7 9740.1 9746.8 9776.8 9787.9 9800.3 5141.2 5147.7 5151.9 5167.9 5207.3 4007.7 4616.2 4666.6 4722.1 4750.4 3842.1 3848.7 3926.3 3944.1 3955.1 1242.0 1254.9 1263.1 1267.2 1270.0 919.7 935.4 946.7 964.0 1007.3 5559.8 5666.3 5678.1 5781.5 5802.0 423.0 425.4 428.8 430.5 437.6 3818.6 3862.5 3864.4 3873.6 3934.4 9799.1 10208.6 10258.4 10281.4 10311.2 9570.9 9881.9 9960.5 10015.9 10154.5 7573.1 7639.2 7655.6 7736.5 7810.5 5300.3 5351.9 5415.2 5423.2 5479.9 8397.5 8581.1 8611.7 8633.5 8729.2 8635.9 8656.9 8728.5 8823.1 9111.7 6596.7 7231.9 7325.9 7406.2 7475.4 7940.5 7993.5 8033.2 8091.5 8097.6 7030.5 7151.9 7240.8 7295.9 7304.7 7067.0 7089.4 7155.9 7192.1 7306.0 6132.5 6311.6 6315.8 6316.0 6347.3 4669.0 4717.2 4718.3 4724.5 4767.3 4706.9 4758.3 4768.6 4810.1 4811.5 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | [#4] prototype.html Cycles:180 Average:5315.85 Median:6127.83 stddev:1608.61 (26.3%) stddev-sans-first:1568.77 06:06:02 INFO - PROCESS | 4590 | Values: 317.6 319.7 323.1 323.4 330.4 5943.6 6089.0 6106.4 6131.2 6156.3 5969.2 5986.0 6016.8 6018.2 6045.8 4302.7 4387.6 4529.5 4536.7 4547.7 4512.8 4538.1 4539.2 4571.2 4576.8 4515.7 4534.8 4541.1 4562.2 4573.0 4378.6 4523.6 4530.5 4534.8 4535.1 3965.5 3976.4 3988.7 3989.0 3993.6 5785.6 5788.9 5801.9 5806.7 5814.9 5147.9 5286.9 5293.8 5308.6 5319.7 6254.7 6275.6 6294.1 6327.9 6351.9 4275.6 4421.8 4424.8 4427.3 4428.0 6555.1 6580.6 6621.8 6652.4 6655.4 4527.2 4528.8 4565.1 4566.2 4575.7 4251.0 4496.1 4628.2 4643.6 4644.1 5226.2 5229.7 5230.4 5234.4 5260.5 6427.0 6427.4 6438.4 6451.6 6464.8 1575.1 1601.7 1617.3 1619.1 1621.1 1056.6 1064.1 1083.8 1083.9 1092.2 6142.4 6150.6 6159.8 6164.9 6181.3 6369.5 6502.6 6548.9 6560.4 6560.7 6063.7 6113.9 6124.4 6138.7 6146.2 3473.3 3487.6 3498.9 3501.3 3522.7 6543.4 6666.9 6726.3 6778.0 6802.1 6556.8 6609.5 6617.2 6627.0 6682.8 6535.4 6689.9 6690.6 6745.0 6768.3 6496.5 6506.9 6521.3 6521.7 6526.8 6286.7 6401.0 6415.9 6437.2 6495.8 6734.3 6780.6 6786.6 6799.9 6804.0 4578.6 4583.7 4594.4 4596.7 4599.1 6281.6 6497.3 6498.8 6502.2 6572.4 6333.2 6351.6 6384.1 6386.1 6399.4 6192.0 6345.2 6389.5 6396.6 6401.1 6228.7 6273.1 6408.2 6415.4 6428.4 6524.2 6548.9 6597.8 6601.3 6608.4 6133.6 6451.2 6457.2 6463.1 6469.1 06:06:02 INFO - PROCESS | 4590 | 06:06:02 INFO - PROCESS | 4590 | [#5] yui.html Cycles:180 Average:14704.78 Median:42896.68 stddev:16457.30 (38.4%) stddev-sans-first:16470.10 06:06:02 INFO - PROCESS | 4590 | Values: 749.3 811.9 813.0 826.7 830.4 14518.6 14787.9 14872.3 14913.5 14980.9 13830.0 13868.9 13920.9 13938.2 13942.2 674.7 803.1 815.8 823.5 838.9 810.6 813.2 813.6 819.3 820.8 869.6 869.7 871.7 875.1 878.6 864.0 865.3 865.5 867.2 874.5 617.2 621.2 626.5 627.8 630.3 14544.3 14599.4 14638.7 14640.2 14687.7 14465.5 14503.1 14526.9 14611.6 14839.1 11202.7 11509.4 11564.8 11775.7 11783.2 3897.8 3910.4 3915.4 3953.1 3989.4 55256.0 55813.7 56127.7 56129.7 56503.2 11433.4 11563.3 11599.7 11614.7 11628.6 20854.7 20931.7 20989.9 21057.3 21116.0 8095.0 8184.4 8211.9 8260.3 8359.4 4726.8 4734.9 4743.0 4793.2 5022.4 3372.5 3486.7 3497.3 3506.4 3511.1 654.4 657.0 683.6 711.2 714.2 654.8 690.3 745.9 759.5 774.2 9209.3 9706.6 9715.5 9874.1 9997.7 606.7 690.5 725.5 767.1 773.4 4366.2 4474.8 4515.3 4536.5 4616.0 54253.5 55462.0 55959.0 68106.3 68878.0 53553.5 53652.7 54259.7 54477.5 56810.4 37463.0 42066.8 42630.4 50382.7 51014.5 9264.2 9618.3 9674.7 9763.1 9820.4 31453.7 31878.7 31983.5 32354.0 32667.3 34153.5 37782.2 39991.0 43163.0 44338.8 12264.8 12276.3 12655.1 12783.3 12872.2 13402.7 13693.2 13998.3 14258.8 14310.8 13173.7 13375.5 13594.4 13605.5 14346.1 12736.9 12833.7 13186.3 13214.7 13532.7 13058.7 13209.8 13231.3 13308.8 13339.3 11048.4 11099.4 11135.4 11264.3 11299.0 10672.7 10819.9 10858.4 10866.6 10891.7 06:06:02 INFO - PROCESS | 4590 | -------- Summary: end -------- 06:06:02 INFO - PROCESS | 4590 | 06:06:03 INFO - TEST-INFO | 4590: exit 0 06:06:03 INFO - TEST-OK | dromaeo_css | took 1109889ms 06:06:03 INFO - TEST-START | kraken 06:06:03 INFO - operating with platform_type : linux_ 06:06:03 INFO - Initialising browser for kraken test... 06:06:03 INFO - TEST-INFO | started process 4817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFAU7qI/profile http://localhost:36107/getInfo.html) 06:06:07 INFO - PROCESS | 4817 | 06:06:07 INFO - PROCESS | 4817 | (process:4885): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:06:07 INFO - PROCESS | 4817 | __metrics Screen width/height:1600/1200 06:06:07 INFO - PROCESS | 4817 | colorDepth:24 06:06:07 INFO - PROCESS | 4817 | Browser inner width/height: 1024/697 06:06:07 INFO - PROCESS | 4817 | __metrics 06:06:08 ERROR - PROCESS | 4817 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:06:09 INFO - TEST-INFO | 4817: exit 0 06:06:09 INFO - Browser initialized. 06:06:09 INFO - Running cycle 1/1 for kraken test... 06:06:09 INFO - TEST-INFO | started process 4936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFAU7qI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:11 INFO - PROCESS | 4936 | 06:06:11 INFO - PROCESS | 4936 | (process:4996): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:06:21 INFO - PROCESS | 4936 | RSS: Main: 163827712 06:06:21 INFO - PROCESS | 4936 | 06:06:23 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36107/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:24 INFO - PROCESS | 4936 | RSS: Main: 168599552 06:06:24 INFO - PROCESS | 4936 | 06:06:27 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36107/tests/kraken/driver.html?testName=audio-dft) 06:06:27 INFO - PROCESS | 4936 | RSS: Main: 171950080 06:06:27 INFO - PROCESS | 4936 | 06:06:30 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36107/tests/kraken/driver.html?testName=audio-fft) 06:06:31 INFO - PROCESS | 4936 | RSS: Main: 164601856 06:06:31 INFO - PROCESS | 4936 | 06:06:33 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36107/tests/kraken/driver.html?testName=audio-oscillator) 06:06:34 INFO - PROCESS | 4936 | RSS: Main: 164945920 06:06:34 INFO - PROCESS | 4936 | 06:06:36 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:37 INFO - PROCESS | 4936 | RSS: Main: 164798464 06:06:37 INFO - PROCESS | 4936 | 06:06:40 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36107/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:40 INFO - PROCESS | 4936 | RSS: Main: 165052416 06:06:40 INFO - PROCESS | 4936 | 06:06:44 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36107/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:44 INFO - PROCESS | 4936 | RSS: Main: 165392384 06:06:44 INFO - PROCESS | 4936 | 06:06:47 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36107/tests/kraken/driver.html?testName=json-parse-financial) 06:06:48 INFO - PROCESS | 4936 | RSS: Main: 165249024 06:06:48 INFO - PROCESS | 4936 | 06:06:49 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:50 INFO - PROCESS | 4936 | RSS: Main: 165691392 06:06:50 INFO - PROCESS | 4936 | 06:06:52 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:52 INFO - PROCESS | 4936 | RSS: Main: 165588992 06:06:52 INFO - PROCESS | 4936 | 06:06:54 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:55 INFO - PROCESS | 4936 | RSS: Main: 165736448 06:06:55 INFO - PROCESS | 4936 | 06:06:58 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:58 INFO - PROCESS | 4936 | RSS: Main: 166699008 06:06:58 INFO - PROCESS | 4936 | 06:07:01 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:02 INFO - PROCESS | 4936 | RSS: Main: 165888000 06:07:02 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | Cycle 1(1): loaded http://localhost:36107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36107/tests/kraken/driver.html?testName=ai-astar) 06:07:04 INFO - PROCESS | 4936 | RSS: Main: 167497728 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | __start_tp_report 06:07:04 INFO - PROCESS | 4936 | _x_x_mozilla_page_load 06:07:04 INFO - PROCESS | 4936 | _x_x_mozilla_page_load_details 06:07:04 INFO - PROCESS | 4936 | |i|pagename|runs| 06:07:04 INFO - PROCESS | 4936 | |0;ai-astar;112;105;111;108;110;123;110;112;109;110 06:07:04 INFO - PROCESS | 4936 | |1;audio-beat-detection;160;129;151;181;134;160;163;128;191;127 06:07:04 INFO - PROCESS | 4936 | |2;audio-dft;163;164;163;163;160;167;166;162;164;162 06:07:04 INFO - PROCESS | 4936 | |3;audio-fft;76;75;75;158;74;78;74;76;165;76 06:07:04 INFO - PROCESS | 4936 | |4;audio-oscillator;93;92;151;93;93;92;154;93;93;156 06:07:04 INFO - PROCESS | 4936 | |5;imaging-gaussian-blur;121;118;117;117;117;117;118;117;117;117 06:07:04 INFO - PROCESS | 4936 | |6;imaging-darkroom;146;146;147;147;146;147;147;150;147;146 06:07:04 INFO - PROCESS | 4936 | |7;imaging-desaturate;96;96;95;96;95;96;95;95;95;94 06:07:04 INFO - PROCESS | 4936 | |8;json-parse-financial;59;59;59;58;58;61;60;83;58;56 06:07:04 INFO - PROCESS | 4936 | |9;json-stringify-tinderbox;61;62;61;62;62;61;61;64;62;63 06:07:04 INFO - PROCESS | 4936 | |10;stanford-crypto-aes;79;79;77;79;78;78;79;77;80;79 06:07:04 INFO - PROCESS | 4936 | |11;stanford-crypto-ccm;127;141;126;124;130;128;129;126;155;137 06:07:04 INFO - PROCESS | 4936 | |12;stanford-crypto-pbkdf2;171;165;168;171;167;176;172;166;172;165 06:07:04 INFO - PROCESS | 4936 | |13;stanford-crypto-sha256-iterative;68;66;69;68;70;70;69;69;67;65 06:07:04 INFO - PROCESS | 4936 | __end_tp_report 06:07:04 INFO - PROCESS | 4936 | __start_cc_report 06:07:04 INFO - PROCESS | 4936 | _x_x_mozilla_cycle_collect,870 06:07:04 INFO - PROCESS | 4936 | __end_cc_report 06:07:04 INFO - PROCESS | 4936 | __startTimestamp1461157624288__endTimestamp 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | ------- Summary: start ------- 06:07:04 INFO - PROCESS | 4936 | Number of tests: 14 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#0] ai-astar Cycles:10 Average:111.00 Median:110.50 stddev:4.69 (4.2%) stddev-sans-first:4.96 06:07:04 INFO - PROCESS | 4936 | Values: 112.0 105.0 111.0 108.0 110.0 123.0 110.0 112.0 109.0 110.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:160.00 stddev:22.77 (14.2%) stddev-sans-first:23.98 06:07:04 INFO - PROCESS | 4936 | Values: 160.0 129.0 151.0 181.0 134.0 160.0 163.0 128.0 191.0 127.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.01 (1.2%) stddev-sans-first:2.13 06:07:04 INFO - PROCESS | 4936 | Values: 163.0 164.0 163.0 163.0 160.0 167.0 166.0 162.0 164.0 162.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:36.32 (48.1%) stddev-sans-first:38.01 06:07:04 INFO - PROCESS | 4936 | Values: 76.0 75.0 75.0 158.0 74.0 78.0 74.0 76.0 165.0 76.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:93.00 stddev:29.47 (31.7%) stddev-sans-first:30.53 06:07:04 INFO - PROCESS | 4936 | Values: 93.0 92.0 151.0 93.0 93.0 92.0 154.0 93.0 93.0 156.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.26 (1.1%) stddev-sans-first:0.44 06:07:04 INFO - PROCESS | 4936 | Values: 121.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 06:07:04 INFO - PROCESS | 4936 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 147.0 150.0 147.0 146.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 06:07:04 INFO - PROCESS | 4936 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 94.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:59.00 stddev:7.81 (13.2%) stddev-sans-first:8.25 06:07:04 INFO - PROCESS | 4936 | Values: 59.0 59.0 59.0 58.0 58.0 61.0 60.0 83.0 58.0 56.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 06:07:04 INFO - PROCESS | 4936 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 61.0 64.0 62.0 63.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 06:07:04 INFO - PROCESS | 4936 | Values: 79.0 79.0 77.0 79.0 78.0 78.0 79.0 77.0 80.0 79.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:129.50 stddev:9.57 (7.4%) stddev-sans-first:9.96 06:07:04 INFO - PROCESS | 4936 | Values: 127.0 141.0 126.0 124.0 130.0 128.0 129.0 126.0 155.0 137.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:171.00 stddev:3.65 (2.1%) stddev-sans-first:3.82 06:07:04 INFO - PROCESS | 4936 | Values: 171.0 165.0 168.0 171.0 167.0 176.0 172.0 166.0 172.0 165.0 06:07:04 INFO - PROCESS | 4936 | 06:07:04 INFO - PROCESS | 4936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.76 06:07:04 INFO - PROCESS | 4936 | Values: 68.0 66.0 69.0 68.0 70.0 70.0 69.0 69.0 67.0 65.0 06:07:04 INFO - PROCESS | 4936 | -------- Summary: end -------- 06:07:04 INFO - PROCESS | 4936 | 06:07:05 INFO - TEST-INFO | 4936: exit 0 06:07:05 INFO - TEST-OK | kraken | took 61943ms 06:07:05 INFO - SUITE-END | took 1171s 06:07:05 INFO - Completed test suite (00:19:32) 06:07:05 INFO - javascript benchmark 06:07:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.6672899345567, 3196.6963138501847, 3221.0497903118576, 3260.918477038074, 3262.5269335946286, 5529.447055294469, 5530.308711411074, 5560.7219639018085, 5566.888662226758, 5568.638038527492, 5440.945590544094, 5582.91625625615, 5615.522680572146, 5624.91562626561, 5723.456271654186, 4982.0, 5014.047331007116, 5107.693538387709, 5112.437631860493, 5137.743112844361, 808.5185025902581, 4894.975525122387, 4929.383827021622, 4955.256711493269, 5025.145725226702, 4977.776000080005, 4989.426215985171, 4995.600351971833, 5004.274380214867, 5012.298278241049, 5026.497350264981, 5032.3961124665275, 5036.06832735945, 5040.949590504085, 5049.267856160836, 4865.343178670905, 4949.381327334083, 4975.402951645826, 5024.397072351341, 5046.26829109777, 5440.401555828856, 5470.863228419282, 5488.725563721798, 5510.8071217507195, 5511.283533140706, 5838.824835254949, 5976.551758618121, 6011.617328014538, 6018.4583387494895, 6032.969835150796, 5959.433853783884, 6036.909446358308, 6057.939420605781, 6086.573939824214, 6108.144859719643, 5536.584756143306, 5540.778368865241, 5546.473085056913, 5559.388467268637, 5561.221428999943, 5900.350961394243, 6035.064564992434, 6042.365551617105, 6078.300995385499, 6088.51291896656, 5879.176915231871, 5887.793927212612, 5893.351731309553, 5897.911531327033, 5928.584999050111, 5912.054071348563, 5937.168796368512, 5941.346451890288, 5945.870284645904, 5988.730507127189, 5785.190073389729, 5873.618214816023, 5911.4975227105315, 5922.2597175353085, 5976.223090998143, 5864.354920958691, 5899.233099697012, 5935.554833387427, 5956.52347812174, 5961.731722072517, 4463.085067561142, 4468.329750537446, 4472.44094488189, 4480.14877173336, 4530.433695788027, 3904.472896159039, 3937.5078115235597, 3972.1261322509004, 3994.141259629194, 4030.8186131624147, 5572.944270557324, 5603.075492543685, 5614.101743720985, 5688.488036076773, 5705.115707065412, 5943.049112142036, 5983.102534619842, 5987.9101813472835, 6017.729202185912, 6019.337872833985, 5573.832785016456, 5583.246261754693, 5648.689322087324, 5675.858103547444, 5709.942900571024, 5074.492550744896, 5128.538431541179, 5145.0, 5148.485151484896, 5157.149070403341, 6187.443130118311, 6202.81391558254, 6206.379362063757, 6230.376962303733, 6235.937640623626, 5856.9999999999145, 5892.35184129754, 5966.910496342645, 5967.0, 5974.253218347707, 6118.464955528275, 6227.408396202353, 6234.15838861766, 6246.344133865879, 6257.8748425030335, 5914.615549989237, 5920.496757775637, 5937.584369094122, 5946.345901950868, 5982.282126144891, 5835.56233282514, 6022.397760223943, 6029.246344206974, 6034.69826508664, 6037.486813620716, 5862.853428664317, 5863.472287494146, 5863.648181109147, 5865.824025279248, 5915.438033386821, 5749.798757043483, 5759.452851979056, 5846.970765146317, 5852.7658893643775, 5875.177475153568, 5677.318721753416, 5731.971340143439, 5755.827325180251, 5781.075027995501, 5820.854478637899, 5798.913016304675, 5844.12338149281, 5865.706714664335, 5878.823635290948, 5900.734466949083, 5750.597458177887, 5755.8561035974435, 5773.826785196451, 5775.7400916957995, 5781.884362312646], "value": 5450.034132021443, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5265335078586, 649.2760571962262, 659.7229163751224, 671.6507416143605, 673.2795908378038, 37255.441168382466, 38015.42976855346, 38383.61616383836, 38734.0, 38738.8063059685, 42284.78857605715, 43014.569854301444, 43207.783961080226, 43261.78369108158, 43336.0, 8716.0, 8916.331275154389, 8917.0, 8919.28645708345, 8932.240759535447, 8645.265152462049, 8722.86915696265, 8751.3436492263, 8798.6920457784, 8808.691695790649, 8728.0, 8829.690960816373, 8849.95575022124, 8863.734087977371, 8878.46729196247, 8733.868991965126, 8760.8685869712, 8802.251808596277, 8829.16122968317, 8829.161229683203, 8780.956095219546, 8882.15619516145, 8886.555672216427, 8887.955560222223, 8890.777730556723, 40955.795221023705, 41057.38413923793, 41104.38343424851, 41212.79393603043, 41276.793616031726, 3451.8274086295582, 3536.522569453117, 3571.4642803579413, 3642.7996460194677, 4152.771597562133, 29965.25086872824, 30152.396952061055, 30429.239269018453, 30531.847340763154, 30537.0, 4169.958300416987, 4202.936955945664, 4314.848980285675, 4378.102488989782, 4422.270325396305, 243307.0, 250554.0, 252593.0, 252837.0, 254419.99999999814, 36824.81587592045, 37754.8112259437, 37843.81078094592, 64073.0, 64745.35254647393, 36609.26781464356, 36681.63318366835, 36802.81598592043, 36947.0, 36999.075023124635, 14370.568882933529, 14502.85497145036, 14600.196989165486, 14618.488352907598, 14667.706645867023, 12106.394680265952, 12321.568745093879, 12359.073069519822, 12364.44360003802, 12389.442475088463, 8809.779755506164, 8838.381313308135, 8868.423552469068, 8873.334499912533, 8898.288136949028, 3370.7303415726683, 3429.0, 3439.518467414564, 3443.7933723976644, 3511.754177207622, 1026.9897301027042, 1027.2141811514198, 1080.2600218850114, 1100.2848148703406, 1148.8851114888444, 31800.84099579487, 32198.517022244687, 32414.67585324164, 32471.837640811646, 32560.0, 1095.912327013837, 1109.5839060352369, 1112.0603090388609, 1128.9717757055976, 1186.163754553038, 16858.24137913797, 17258.82741172597, 17804.198811053535, 17914.731279030824, 18032.909835451002, 343022.0, 344704.0, 348106.0, 348649.0, 348670.0, 58178.0, 59407.702961484916, 59542.0, 59706.10440843391, 59736.0, 1324.2120938041849, 1335.5226055666988, 1350.108928107464, 1352.6753579140936, 1355.9322033898463, 32233.194170145933, 32623.510647340783, 32947.0, 32972.67027329696, 32997.17507062342, 51621.22568161556, 51865.48134518607, 52411.73794131158, 52449.21326180034, 52496.0, 428406.0, 429368.0, 432132.0, 433906.0, 435915.0, 28771.712282876902, 29093.7090629091, 29218.269543261587, 29547.85226073856, 29630.111096667133, 46896.29655555238, 47283.29075063808, 48293.275600865316, 49034.50965490299, 49693.25460118029, 40145.1970960585, 41068.38397423981, 42312.36531451969, 42726.0, 42920.0, 39988.20878445577, 41411.7929410351, 41487.377689335284, 41491.0, 42043.1591368177, 41179.58820411757, 41735.165296694504, 41775.7911210442, 42041.15917681568, 42972.78513607412, 35968.460473093444, 36945.07637309089, 37022.81488592648, 37503.249935000604, 37538.436923446716, 27917.302067447665, 28057.897248289766, 28269.39929891641, 28378.2905427366, 28407.147785566467], "value": 18492.42417783437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.73837790302616, 386.7795356646712, 393.43934892777787, 399.38846753350236, 400.0618549501418, 14635.19506427146, 17872.37446689366, 17912.910435447822, 18507.907460462695, 18655.067246637664, 16219.432319868778, 16894.662106757856, 17014.0, 17015.659686806255, 17168.82831171688, 5657.038303488417, 5710.543156547487, 5741.19623252745, 5850.151727999438, 5887.0286402743495, 5721.170430287606, 5754.1944127822135, 5768.451997060272, 5810.15752715856, 5825.708714564276, 5546.722663866811, 5776.480116789488, 5783.421657834225, 5823.475887170154, 5825.796097136601, 5711.685857277848, 5731.484166425, 5731.942680573183, 5743.885122297531, 5810.477057064863, 4953.455119936804, 5165.845024649267, 5170.1986192140275, 5170.534651881311, 5181.948180518184, 21936.89031554832, 22420.215292464847, 22813.429664258525, 22995.77004229953, 23009.654855177185, 2044.826189773871, 2099.191811152702, 2141.0472339808794, 2290.690756747851, 2297.287840769367, 14066.71866562663, 14351.138931664029, 14525.564233073024, 14562.199079050648, 14653.853461465356, 1958.128632758423, 2046.7441569803775, 2059.588082383529, 2060.258307009475, 2066.2664754012258, 81210.0, 81241.18758812395, 81590.59204703939, 81780.59109704413, 82178.0, 10037.648682296085, 10178.23663225261, 10556.63051793199, 10569.947150264199, 10784.94607526973, 13037.478500860048, 13703.657408564666, 14716.77924831107, 14829.40682372693, 14833.184174870486, 7802.570858602831, 7930.1276859545405, 8153.714619988391, 8356.540390278471, 8409.075001749803, 8060.758177254692, 8089.150639182919, 8103.392245581605, 8227.465214761021, 8230.670773169126, 6373.745050198033, 6566.080748695186, 6644.202695676549, 6662.400383965466, 6680.732770689216, 1843.8340549350623, 1897.5066482714594, 1906.447130332216, 1912.6174765046767, 1945.8443324534287, 910.3081657940013, 998.7752755630071, 1071.2287153249647, 1076.7738774857212, 1115.525139191413, 18886.3389781357, 19622.411327660193, 19640.0, 19731.802681972997, 19844.50388740293, 1012.4684540616088, 1025.553884060436, 1035.2649618770756, 1048.3238311289176, 1071.4160782373624, 10863.67408977732, 11147.888521114684, 11156.832647510293, 11184.0, 11199.160062995144, 374856.0, 383177.0, 458297.0, 459005.0, 462786.0, 84575.15424845673, 91588.0, 95959.0, 95977.0, 98361.0, 1036.5439206749006, 1038.4029183219527, 1069.6202847989007, 1103.6799328194895, 1115.7043383503378, 16269.59326016859, 16277.267522961258, 16290.10404427768, 16507.9174604131, 16559.751603725712, 28014.579781302888, 38191.80904095462, 39506.60493395144, 39971.40042899301, 39980.80009599934, 51256.48743512517, 52685.0, 53183.46816531785, 53430.4656953441, 54020.0, 8474.0, 8477.15228477172, 8577.0, 8639.308855291436, 8996.955015224881, 8997.0, 12273.815892761795, 13109.213447193199, 13261.867381326063, 13487.730245395234, 11257.21199516026, 11389.259698119597, 11424.428778560872, 11710.531578736754, 11792.916074677765, 11554.537818487503, 11693.532258709556, 11778.823317650413, 11784.646460606196, 11890.702732431759, 11436.37099959477, 11603.477843497232, 11711.941440293085, 12004.699882503008, 12147.635570932885, 7307.086614173229, 7646.617669116633, 7693.692252309845, 8036.397270204641, 8544.316454683734, 10899.509522071367, 11253.847650501288, 11324.32054076758, 11508.53965841357, 11871.940640296743], "value": 9180.96678045848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.1954734669607, 1477.3647331647392, 1652.4051341517052, 1689.6029433083215, 1796.8562514998794, 7459.291367320109, 7864.095629002666, 7964.601769911503, 8338.541380224093, 8359.874601880969, 7949.165337639552, 7954.522728636286, 7970.442069055154, 7992.0, 8054.275115239628, 2216.601011817872, 2254.4363909022786, 2267.0591704442636, 2268.1947908492493, 2270.0465804362207, 2175.358269310549, 2175.3800166952424, 2215.2025270902463, 2221.511267521151, 2244.0350649220827, 2244.618414869468, 2255.796978271955, 2257.142285931352, 2279.521300526883, 2304.8617082974993, 2173.89130543473, 2174.6085704573093, 2175.5105101352146, 2182.71624688791, 2184.945376365588, 2212.760853921809, 2225.7662945390825, 2225.844190906621, 2227.9331620051425, 2229.4203507088273, 8045.195480451966, 8046.919530804676, 8049.195080491904, 8053.677852885936, 8080.353571714249, 4964.702117872939, 5099.821506247301, 5127.641065125443, 5182.611304152166, 5188.533032027136, 3124.4844600640868, 3235.902922912316, 3291.0620473165272, 3320.9833950830334, 3368.4105281575626, 1139.2082502660653, 1143.9599614013553, 1180.4982882274999, 1193.2721040165493, 1204.7289359894041, 11383.601573944872, 11384.430778461126, 11474.082073434105, 11509.942450287695, 11516.25144365622, 4381.430414046217, 4395.099004704028, 4517.909641807146, 4544.954550454519, 4562.657800664963, 9740.074692904305, 9746.756331091638, 9776.826780786208, 9787.85318220213, 9800.26498012652, 5141.177411614124, 5147.6654017488745, 5151.948480515147, 5167.870803229949, 5207.270982062514, 4007.6593489553716, 4616.238320677118, 4666.603338716247, 4722.055588882237, 4750.382450281441, 3842.135519508144, 3848.7113466490127, 3926.293267211929, 3944.073142811437, 3955.0705584187695, 1242.031215651793, 1254.8933340665963, 1263.0842639086588, 1267.2206592945456, 1269.993650031744, 919.6873063158424, 935.3639525122845, 946.6592026870321, 963.9951800240954, 1007.2596641468515, 5559.77760889568, 5666.263385759825, 5678.0915053591225, 5781.479666829921, 5802.013657678205, 422.96404805591254, 425.4044337926927, 428.75775187019235, 430.476970480861, 437.61271274921285, 3818.6181381862148, 3862.517185351831, 3864.3623802072907, 3873.6320049595242, 3934.3705007199283, 9799.118079372749, 10208.591656333663, 10258.43578603184, 10281.434521101412, 10311.22665800068, 9570.90429095714, 9881.901180988241, 9960.501974901226, 10015.899841001497, 10154.492275386348, 7573.091229052549, 7639.197884222188, 7655.57894315818, 7736.535807851435, 7810.45326827128, 5300.337457817773, 5351.866203344947, 5415.160650099241, 5423.240746295601, 5479.863003424946, 8397.538135402612, 8581.141885811368, 8611.65553377858, 8633.525156116473, 8729.170728780755, 8635.870461943201, 8656.91343086561, 8728.519931403835, 8823.073577274294, 9111.681091161778, 6596.736130554724, 7231.927680723125, 7325.853482930418, 7406.185319614946, 7475.43934204926, 7940.483868548526, 7993.4804237726685, 8033.236842499953, 8091.474054186459, 8097.554634494923, 7030.543014704028, 7151.892721609076, 7240.782776516713, 7295.890561641686, 7304.744333948286, 7066.964665176642, 7089.361957423856, 7155.892661610184, 7192.100987376578, 7306.0, 6132.47873930703, 6311.621302721851, 6315.778947736807, 6316.0, 6347.333529979285, 4668.953310466852, 4717.2216584263215, 4718.268668356411, 4724.503927087606, 4767.284907263938, 4706.929396058993, 4758.31004504338, 4768.57082862544, 4810.11012962603, 4811.470738218723], "value": 4297.536589154771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.5776217630551, 319.6627557926388, 323.06794896722954, 323.4291475545662, 330.3525090821989, 5943.554233432488, 6088.969555152229, 6106.419890110438, 6131.202943617329, 6156.322804491502, 5969.194158788562, 5986.0, 6016.826718789837, 6018.15745795589, 6045.848853778647, 4302.698811083217, 4387.62705170061, 4529.547045295477, 4536.682432229745, 4547.681662283641, 4512.819487220508, 4538.069695712387, 4539.205639013159, 4571.222892108333, 4576.771161441931, 4515.683902126836, 4534.841280555182, 4541.114482675879, 4562.224421848277, 4573.010740327952, 4378.62781663559, 4523.570260825217, 4530.456345238559, 4534.750588717619, 4535.115652447774, 3965.543962444327, 3976.363781794928, 3988.720789544733, 3988.9800550997347, 3993.5806740292433, 5785.566082543826, 5788.942110578924, 5801.9129713054335, 5806.680632565207, 5814.883702325972, 5147.948520514784, 5286.867828304323, 5293.75596734767, 5308.601854860901, 5319.654222475527, 6254.655993920333, 6275.623462592259, 6294.087357333161, 6327.936720632781, 6351.920173570504, 4275.572442755731, 4421.756803375813, 4424.756638384888, 4427.2695005324085, 4428.0, 6555.147830782015, 6580.585174187525, 6621.801345959629, 6652.434543063845, 6655.401013908771, 4527.185106680829, 4528.818847246073, 4565.109803588335, 4566.223741963874, 4575.725456472623, 4250.957490425118, 4496.055828276033, 4628.166929952574, 4643.582077613031, 4644.140833945663, 5226.163813789852, 5229.686218826882, 5230.378582639394, 5234.398044224887, 5260.526552610207, 6427.0, 6427.421532062043, 6438.356164383524, 6451.612903225821, 6464.806055818333, 1575.1021917506912, 1601.7036848183122, 1617.3288085444644, 1619.1337634365557, 1621.1407953784512, 1056.6143357674548, 1064.095518809006, 1083.7994970930404, 1083.8970297821695, 1092.2408925796494, 6142.3550527194, 6150.630962142286, 6159.81520554384, 6164.907526387108, 6181.289151747516, 6369.5222858285815, 6502.642354670538, 6548.901766473411, 6560.44236239925, 6560.737570497126, 6063.6664983426335, 6113.877722445526, 6124.448799608057, 6138.7237574309265, 6146.200993870768, 3473.2879759649213, 3487.616362200156, 3498.930021399558, 3501.2647344057523, 3522.682958533744, 6543.44380727634, 6666.866662666719, 6726.284797376736, 6778.0, 6802.14973128359, 6556.770513032021, 6609.537332386687, 6617.2059352877, 6627.0, 6682.799516014527, 6535.379138981789, 6689.866202675919, 6690.59856408617, 6745.0, 6768.289329620417, 6496.480281577557, 6506.934930650633, 6521.315261897433, 6521.67391630426, 6526.804195874131, 6286.654234017173, 6400.967995160181, 6415.935840641534, 6437.227532696106, 6495.805125846232, 6734.259231484435, 6780.593164410151, 6786.626735529593, 6799.898001529882, 6803.965980170067, 4578.633709303314, 4583.702059366131, 4594.425696787902, 4596.678232523691, 4599.057193275304, 6281.607931717004, 6497.310699218332, 6498.837529061811, 6502.219733631994, 6572.4084832365315, 6333.240011198685, 6351.587146835441, 6384.07430922523, 6386.074019267273, 6399.360063993563, 6192.0, 6345.238571371465, 6389.52078594098, 6396.648184349905, 6401.135846660642, 6228.719707613259, 6273.14942092093, 6408.198975128109, 6415.390537898892, 6428.389303016206, 6524.184476940382, 6548.869022619426, 6597.80206593803, 6601.339866013553, 6608.4382827458285, 6133.601315914451, 6451.1936007999, 6457.223393940651, 6463.095166676575, 6469.118528882633], "value": 4787.366016443797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.3068911257086, 811.8741595052761, 812.9918700812991, 826.6693322670931, 830.4353039932847, 14518.564443066713, 14787.926060369684, 14872.33074511647, 14913.478028269026, 14980.850191498082, 13829.962752793555, 13868.930655346734, 13920.860791392082, 13938.233397163152, 13942.233177175276, 674.740225013371, 803.1486624178375, 815.7634286057037, 823.5017814222399, 838.8993320801512, 810.5987536169604, 813.2436833744615, 813.5647428625687, 819.3404309530825, 820.7660816667251, 869.6390997735932, 869.7086476030506, 871.7210492642357, 875.0549406640845, 878.6397576993434, 864.0452300208242, 865.2947847504264, 865.4590880699562, 867.2195024477958, 874.4927941793744, 617.222299902122, 621.2048577820398, 626.5426238845669, 627.8493161641219, 630.2594451519446, 14544.272786360745, 14599.41602335916, 14638.707225855424, 14640.194789286585, 14687.70624587513, 14465.49370772018, 14503.1298122113, 14526.854731452657, 14611.63470913225, 14839.10965342072, 11202.66392008241, 11509.424528773528, 11564.826527602092, 11775.7056073598, 11783.234089784137, 3897.80510974453, 3910.432987216838, 3915.432262321976, 3953.0710283083454, 3989.4215338775716, 55256.0, 55813.72093139549, 56127.71936140334, 56129.71935140298, 56503.15245271324, 11433.428328583537, 11563.306201627762, 11599.666038405692, 11614.6515604532, 11628.592999244986, 20854.687179692315, 20931.68602470964, 20989.89505052465, 21057.262995795074, 21116.0, 8094.959525202454, 8184.427090103754, 8211.876821847676, 8260.297874680598, 8359.373047021498, 4726.787294571684, 4734.905301893943, 4742.976285118552, 4793.209120495149, 5022.372203474566, 3372.4941258811373, 3486.6687664671817, 3497.2655742293896, 3506.403911335079, 3511.0871173495075, 654.4044919123575, 657.0374401501823, 683.6274230544366, 711.2389742974967, 714.2107970692414, 654.8166513376262, 690.3407246079981, 745.9030326057687, 759.4987308376556, 774.156169774948, 9209.263258939403, 9706.563204655808, 9715.46564938935, 9874.111329980193, 9997.700068997796, 606.7360698096343, 690.492488021304, 725.4994054102652, 767.075673813054, 773.3619763694974, 4366.170427618742, 4474.798634061475, 4515.254982927846, 4536.500984891659, 4616.0, 54253.45746542563, 55462.0, 55959.0, 68106.31893681, 68878.0, 53553.464465354846, 53652.73173634107, 54259.72870135624, 54477.45522544803, 56810.431895681344, 37463.0, 42066.789666052086, 42630.36054459186, 50382.748086260064, 51014.48985510172, 9264.166225039779, 9618.326717129734, 9674.70975870725, 9763.142114731105, 9820.361676491006, 31453.685463145077, 31878.68121318757, 31983.520247195844, 32354.0, 32667.34665306728, 34153.48769768505, 37782.2443551133, 39991.0, 43163.0, 44338.77830610827, 12264.816027759412, 12276.324802135969, 12655.11414201034, 12783.296918669563, 12872.16330938486, 13402.731945361233, 13693.178409295475, 13998.300084995506, 14258.786118208443, 14310.785338220143, 13173.670658233621, 13375.53185638498, 13594.388252528857, 13605.523806666719, 14346.139231646135, 12736.87263127394, 12833.743325133632, 13186.340682966005, 13214.735705285648, 13532.661683457993, 13058.738825223252, 13209.801852972021, 13231.27228002469, 13308.800367994294, 13339.266340350985, 11048.392338421143, 11099.389533575408, 11135.387553684624, 11264.267822591506, 11299.0, 10672.679819605424, 10819.891801081889, 10858.402787846428, 10866.61966831157, 10891.727706807393], "value": 6862.411371357422, "unit": "score"}], "name": "dromaeo_css", "value": 7123.373144288802, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 108.0, 110.0, 123.0, 110.0, 112.0, 109.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 151.0, 181.0, 134.0, 160.0, 163.0, 128.0, 191.0, 127.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 160.0, 167.0, 166.0, 162.0, 164.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 158.0, 74.0, 78.0, 74.0, 76.0, 165.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 151.0, 93.0, 93.0, 92.0, 154.0, 93.0, 93.0, 156.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 150.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 58.0, 61.0, 60.0, 83.0, 58.0, 56.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 64.0, 62.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 79.0, 78.0, 78.0, 79.0, 77.0, 80.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 141.0, 126.0, 124.0, 130.0, 128.0, 129.0, 126.0, 155.0, 137.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 168.0, 171.0, 167.0, 176.0, 172.0, 166.0, 172.0, 165.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 68.0, 70.0, 70.0, 69.0, 69.0, 67.0, 65.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1561.4999999999998, "alertThreshold": 2.0}]} 06:07:05 INFO - Return code: 0 06:07:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:07:05 ERROR - # TBPL SUCCESS # 06:07:05 INFO - Running post-action listener: _resource_record_post_action 06:07:05 INFO - Running post-run listener: _resource_record_post_run 06:07:06 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 135168; Write bytes: 361938944; Read time: 48; Write time: 261780 06:07:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 76931072; Read time: 0; Write time: 57136 06:07:06 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 135168; Write bytes: 285007872; Read time: 48; Write time: 204644 06:07:06 INFO - Running post-run listener: _upload_blobber_files 06:07:06 INFO - Blob upload gear active. 06:07:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:06 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:07:06 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:07:06 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:07:07 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:07 INFO - (blobuploader) - INFO - Done attempting. 06:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:08 INFO - (blobuploader) - INFO - Done attempting. 06:07:08 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:08 INFO - Return code: 0 06:07:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd86cfc7bbec95208f60b43a20153968351ecd0a279d1074b973604ce9a9a1abffb021d09e32a337c5c4cd194228b9c3082beffba892d66a19c80512e8f3c45c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d56ef27ff523bd4d79ba07dfbd06816290c6d61689f324732e1c815acbc5a858ecc1c2c615776e2aa86e4fa66c4c7972be84470de3af9c495fa01f0e85e9228a"} 06:07:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:08 INFO - Contents: 06:07:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd86cfc7bbec95208f60b43a20153968351ecd0a279d1074b973604ce9a9a1abffb021d09e32a337c5c4cd194228b9c3082beffba892d66a19c80512e8f3c45c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d56ef27ff523bd4d79ba07dfbd06816290c6d61689f324732e1c815acbc5a858ecc1c2c615776e2aa86e4fa66c4c7972be84470de3af9c495fa01f0e85e9228a"} 06:07:08 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:08 INFO - Copying logs to upload dir... 06:07:08 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.926896 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-20 06:07:08.690471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 06:07:08.694548) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409 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/dd86cfc7bbec95208f60b43a20153968351ecd0a279d1074b973604ce9a9a1abffb021d09e32a337c5c4cd194228b9c3082beffba892d66a19c80512e8f3c45c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d56ef27ff523bd4d79ba07dfbd06816290c6d61689f324732e1c815acbc5a858ecc1c2c615776e2aa86e4fa66c4c7972be84470de3af9c495fa01f0e85e9228a"} build_url:https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/VqO4xUwjSneAGYDXyFA-og/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/dd86cfc7bbec95208f60b43a20153968351ecd0a279d1074b973604ce9a9a1abffb021d09e32a337c5c4cd194228b9c3082beffba892d66a19c80512e8f3c45c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d56ef27ff523bd4d79ba07dfbd06816290c6d61689f324732e1c815acbc5a858ecc1c2c615776e2aa86e4fa66c4c7972be84470de3af9c495fa01f0e85e9228a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 06:07:08.719505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:07:08.719833) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461155870.970754-422898409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004350 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 06:07:08.888101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 06:07:08.888427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 06:07:08.888707) ========= ========= Total master_lag: 0.25 =========