builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1462547337.15 results: success (0) buildid: 20160506052037 builduid: 272a1b5faa8b4aa5992a327d5003c110 revision: 19a1743ceb2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.151447) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.152007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.152332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.169838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.170217) ========= 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=4300f881736b422476174874000001bc-1462546688.476896-1627948680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 08:08:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.9M=0s 2016-05-06 08:08:58 (80.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.250389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.434162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.434508) ========= 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=4300f881736b422476174874000001bc-1462546688.476896-1627948680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019901 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:57.484955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 08:08:57.485369) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19a1743ceb2e --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 19a1743ceb2e --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=4300f881736b422476174874000001bc-1462546688.476896-1627948680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 08:08:58,145 Setting DEBUG logging. 2016-05-06 08:08:58,145 attempt 1/10 2016-05-06 08:08:58,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19a1743ceb2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 08:08:58,884 unpacking tar archive at: mozilla-central-19a1743ceb2e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.006484 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 08:08:58.505140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:58.505508) ========= script_repo_revision: 19a1743ceb2e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:58.505963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:58.506266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 08:08:58.516101) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-06 08:08:58.516478) ========= /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=4300f881736b422476174874000001bc-1462546688.476896-1627948680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:59 INFO - MultiFileLogger online at 20160506 08:08:59 in /builds/slave/test 08:08:59 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 08:08:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:59 INFO - {'append_to_log': False, 08:08:59 INFO - 'base_work_dir': '/builds/slave/test', 08:08:59 INFO - 'blob_upload_branch': 'Firefox', 08:08:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:59 INFO - 'branch': 'Firefox', 08:08:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:59 INFO - 'config_files': ('talos/linux_config.py',), 08:08:59 INFO - 'default_actions': ('clobber', 08:08:59 INFO - 'read-buildbot-config', 08:08:59 INFO - 'download-and-extract', 08:08:59 INFO - 'populate-webroot', 08:08:59 INFO - 'create-virtualenv', 08:08:59 INFO - 'install', 08:08:59 INFO - 'run-tests'), 08:08:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:59 INFO - 'download_minidump_stackwalk': True, 08:08:59 INFO - 'download_symbols': 'ondemand', 08:08:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:59 INFO - 'installer_path': 'installer.exe', 08:08:59 INFO - 'log_level': 'info', 08:08:59 INFO - 'log_name': 'talos', 08:08:59 INFO - 'log_to_console': True, 08:08:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:59 INFO - 'opt_config_files': (), 08:08:59 INFO - 'pip_index': False, 08:08:59 INFO - 'sps_profile': False, 08:08:59 INFO - 'sps_profile_interval': 0, 08:08:59 INFO - 'suite': 'dromaeojs-e10s', 08:08:59 INFO - 'system_bits': '32', 08:08:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:59 INFO - 'title': 'talos-linux64-ix-045', 08:08:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:59 INFO - 'use_talos_json': True, 08:08:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:59 INFO - 'work_dir': 'build'} 08:08:59 INFO - ##### 08:08:59 INFO - ##### Running clobber step. 08:08:59 INFO - ##### 08:08:59 INFO - Running pre-action listener: _resource_record_pre_action 08:08:59 INFO - Running main action method: clobber 08:08:59 INFO - rmtree: /builds/slave/test/build 08:08:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:00 INFO - Running post-action listener: _resource_record_post_action 08:09:00 INFO - ##### 08:09:00 INFO - ##### Finished clobber step (success) 08:09:00 INFO - ##### 08:09:00 INFO - ##### 08:09:00 INFO - ##### Running read-buildbot-config step. 08:09:00 INFO - ##### 08:09:00 INFO - Running pre-action listener: _resource_record_pre_action 08:09:00 INFO - Running main action method: read_buildbot_config 08:09:00 INFO - Using buildbot properties: 08:09:00 INFO - { 08:09:00 INFO - "project": "", 08:09:00 INFO - "product": "firefox", 08:09:00 INFO - "script_repo_revision": "production", 08:09:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:09:00 INFO - "repository": "", 08:09:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:09:00 INFO - "buildid": "20160506052037", 08:09:00 INFO - "stage_platform": "linux64-pgo", 08:09:00 INFO - "basedir": "/builds/slave/test", 08:09:00 INFO - "nightly_build": "True", 08:09:00 INFO - "buildnumber": 725, 08:09:00 INFO - "slavename": "talos-linux64-ix-045", 08:09:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:09:00 INFO - "platform": "ubuntu64_hw", 08:09:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:09:00 INFO - "branch": "mozilla-central", 08:09:00 INFO - "repo_path": "mozilla-central", 08:09:00 INFO - "revision": "19a1743ceb2e", 08:09:00 INFO - "pgo_build": "True", 08:09:00 INFO - "builduid": "272a1b5faa8b4aa5992a327d5003c110", 08:09:00 INFO - "slavebuilddir": "test" 08:09:00 INFO - } 08:09:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:09:00 INFO - Running post-action listener: _resource_record_post_action 08:09:00 INFO - ##### 08:09:00 INFO - ##### Finished read-buildbot-config step (success) 08:09:00 INFO - ##### 08:09:00 INFO - ##### 08:09:00 INFO - ##### Running download-and-extract step. 08:09:00 INFO - ##### 08:09:00 INFO - Running pre-action listener: _resource_record_pre_action 08:09:00 INFO - Running main action method: download_and_extract 08:09:00 INFO - mkdir: /builds/slave/test/build/tests 08:09:00 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')]} 08:09:00 INFO - https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:09:00 INFO - Downloaded 1361 bytes. 08:09:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:09:00 INFO - Using the following test package requirements: 08:09:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:09:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:09:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'jsshell-linux-x86_64.zip'], 08:09:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:09:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:09:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:09:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:09:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:09:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:09:00 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')]} 08:09:00 INFO - https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:05 INFO - Downloaded 23893813 bytes. 08:09:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:09:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:09:06 INFO - Return code: 0 08:09:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:09:06 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')]} 08:09:06 INFO - https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:08 INFO - Downloaded 23893813 bytes. 08:09:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:09:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:09:09 INFO - Return code: 0 08:09: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')]} 08:09:09 INFO - https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:09:10 INFO - Downloaded 10840152 bytes. 08:09:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:09:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:09:11 INFO - Return code: 0 08:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:11 INFO - https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:09:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:09:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:09:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:09:12 INFO - Downloaded 58409439 bytes. 08:09:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:09:12 INFO - mkdir: /builds/slave/test/properties 08:09:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:12 INFO - Contents: 08:09:12 INFO - build_url:https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:09:13 INFO - Running post-action listener: _resource_record_post_action 08:09:13 INFO - Running post-action listener: set_extra_try_arguments 08:09:13 INFO - ##### 08:09:13 INFO - ##### Finished download-and-extract step (success) 08:09:13 INFO - ##### 08:09:13 INFO - ##### 08:09:13 INFO - ##### Running populate-webroot step. 08:09:13 INFO - ##### 08:09:13 INFO - Running pre-action listener: _resource_record_pre_action 08:09:13 INFO - Running main action method: populate_webroot 08:09:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:13 INFO - '--tppagecycles', 08:09:13 INFO - '7'], 08:09:13 INFO - 'tests': ['tsvgm']}}, 08:09:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['damp', 'tps']}, 08:09:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'tests': ['damp', 'tps']}, 08:09:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['dromaeo_dom']}, 08:09:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['a11yr', 08:09:13 INFO - 'ts_paint', 08:09:13 INFO - 'tpaint', 08:09:13 INFO - 'sessionrestore', 08:09:13 INFO - 'sessionrestore_no_auto_restore', 08:09:13 INFO - 'tabpaint']}, 08:09:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:13 INFO - 'ts_paint', 08:09:13 INFO - 'tpaint', 08:09:13 INFO - 'sessionrestore', 08:09:13 INFO - 'sessionrestore_no_auto_restore', 08:09:13 INFO - 'tabpaint']}, 08:09:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:13 INFO - 'ts_paint', 08:09:13 INFO - 'tpaint', 08:09:13 INFO - 'sessionrestore', 08:09:13 INFO - 'sessionrestore_no_auto_restore', 08:09:13 INFO - 'tabpaint']}, 08:09:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:13 INFO - 'ts_paint', 08:09:13 INFO - 'tpaint', 08:09:13 INFO - 'sessionrestore', 08:09:13 INFO - 'sessionrestore_no_auto_restore', 08:09:13 INFO - 'tabpaint']}, 08:09:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['a11yr', 08:09:13 INFO - 'ts_paint', 08:09:13 INFO - 'tpaint', 08:09:13 INFO - 'sessionrestore', 08:09:13 INFO - 'sessionrestore_no_auto_restore', 08:09:13 INFO - 'tabpaint']}, 08:09:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['a11yr', 08:09:13 INFO - 'ts_paint', 08:09:13 INFO - 'tpaint', 08:09:13 INFO - 'sessionrestore', 08:09:13 INFO - 'sessionrestore_no_auto_restore', 08:09:13 INFO - 'tabpaint']}, 08:09:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['tsvgx', 08:09:13 INFO - 'tsvgr_opacity', 08:09:13 INFO - 'tart', 08:09:13 INFO - 'tscrollx', 08:09:13 INFO - 'cart']}, 08:09:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:13 INFO - 'tsvgr_opacity', 08:09:13 INFO - 'tart', 08:09:13 INFO - 'tscrollx', 08:09:13 INFO - 'cart']}, 08:09:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'talos_options': ['--disable-e10s'], 08:09:13 INFO - 'tests': ['tp5o']}, 08:09:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'tests': ['tp5o']}, 08:09:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'talos_options': ['--disable-e10s', 08:09:13 INFO - '--xperf_path', 08:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:13 INFO - 'tests': ['tp5n']}, 08:09:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:13 INFO - 'talos_options': ['--xperf_path', 08:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:13 INFO - 'tests': ['tp5n']}}, 08:09:13 INFO - 'talos.zip': {'path': '', 08:09:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:13 INFO - Running post-action listener: _resource_record_post_action 08:09:13 INFO - ##### 08:09:13 INFO - ##### Finished populate-webroot step (success) 08:09:13 INFO - ##### 08:09:13 INFO - ##### 08:09:13 INFO - ##### Running create-virtualenv step. 08:09:13 INFO - ##### 08:09:13 INFO - Running pre-action listener: _resource_record_pre_action 08:09:13 INFO - Running main action method: create_virtualenv 08:09:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:13 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 08:09:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:13 INFO - Using real prefix '/usr' 08:09:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:13 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:15 INFO - Installing pip.................done. 08:09:15 INFO - Return code: 0 08:09:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:15 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')]} 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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')]} 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:15 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 08:09:15 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 08:09:15 INFO - Using env: {'DISPLAY': ':0', 08:09:15 INFO - 'HOME': '/home/cltbld', 08:09:15 INFO - 'LANG': 'en_US.UTF-8', 08:09:15 INFO - 'LANGUAGE': 'en_US:en', 08:09:15 INFO - 'LOGNAME': 'cltbld', 08:09:15 INFO - 'MAIL': '/var/mail/cltbld', 08:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:15 INFO - 'MOZ_NO_REMOTE': '1', 08:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:15 INFO - 'NO_EM_RESTART': '1', 08:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:15 INFO - 'PWD': '/builds/slave/test', 08:09:15 INFO - 'SHELL': '/bin/bash', 08:09:15 INFO - 'SHLVL': '1', 08:09:15 INFO - 'TERM': 'linux', 08:09:15 INFO - 'TMOUT': '86400', 08:09:15 INFO - 'USER': 'cltbld', 08:09:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:15 INFO - '_': '/tools/buildbot/bin/python'} 08:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:15 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 08:09:15 INFO - Cleaning up... 08:09:15 INFO - Return code: 0 08:09:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:09:15 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')]} 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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')]} 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:15 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 08:09:15 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 08:09:15 INFO - Using env: {'DISPLAY': ':0', 08:09:15 INFO - 'HOME': '/home/cltbld', 08:09:15 INFO - 'LANG': 'en_US.UTF-8', 08:09:15 INFO - 'LANGUAGE': 'en_US:en', 08:09:15 INFO - 'LOGNAME': 'cltbld', 08:09:15 INFO - 'MAIL': '/var/mail/cltbld', 08:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:15 INFO - 'MOZ_NO_REMOTE': '1', 08:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:15 INFO - 'NO_EM_RESTART': '1', 08:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:15 INFO - 'PWD': '/builds/slave/test', 08:09:15 INFO - 'SHELL': '/bin/bash', 08:09:15 INFO - 'SHLVL': '1', 08:09:15 INFO - 'TERM': 'linux', 08:09:15 INFO - 'TMOUT': '86400', 08:09:15 INFO - 'USER': 'cltbld', 08:09:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:15 INFO - '_': '/tools/buildbot/bin/python'} 08:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:16 INFO - Downloading/unpacking psutil>=0.7.1 08:09:16 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 08:09:16 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 08:09:16 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 08:09:16 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 08:09:16 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 08:09:16 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 08:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:18 INFO - Installing collected packages: psutil 08:09:18 INFO - Running setup.py install for psutil 08:09:18 INFO - building 'psutil._psutil_linux' extension 08:09:18 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 08:09:18 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 08:09:18 INFO - building 'psutil._psutil_posix' extension 08:09:18 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 08:09:18 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 08:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:18 INFO - Successfully installed psutil 08:09:18 INFO - Cleaning up... 08:09:18 INFO - Return code: 0 08:09:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:18 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:18 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 08:09:18 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 08:09:18 INFO - Using env: {'DISPLAY': ':0', 08:09:18 INFO - 'HOME': '/home/cltbld', 08:09:18 INFO - 'LANG': 'en_US.UTF-8', 08:09:18 INFO - 'LANGUAGE': 'en_US:en', 08:09:18 INFO - 'LOGNAME': 'cltbld', 08:09:18 INFO - 'MAIL': '/var/mail/cltbld', 08:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:18 INFO - 'MOZ_NO_REMOTE': '1', 08:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:18 INFO - 'NO_EM_RESTART': '1', 08:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:18 INFO - 'PWD': '/builds/slave/test', 08:09:18 INFO - 'SHELL': '/bin/bash', 08:09:18 INFO - 'SHLVL': '1', 08:09:18 INFO - 'TERM': 'linux', 08:09:18 INFO - 'TMOUT': '86400', 08:09:18 INFO - 'USER': 'cltbld', 08:09:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:18 INFO - '_': '/tools/buildbot/bin/python'} 08:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:09:18 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 08:09:18 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 08:09:18 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 08:09:18 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 08:09:18 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 08:09:18 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 08:09:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:09:20 INFO - Installing collected packages: mozsystemmonitor 08:09:20 INFO - Running setup.py install for mozsystemmonitor 08:09:20 INFO - Successfully installed mozsystemmonitor 08:09:20 INFO - Cleaning up... 08:09:20 INFO - Return code: 0 08:09:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:20 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')]} 08:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:20 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')]} 08:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:20 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:20 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 08:09:20 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 08:09:20 INFO - Using env: {'DISPLAY': ':0', 08:09:20 INFO - 'HOME': '/home/cltbld', 08:09:20 INFO - 'LANG': 'en_US.UTF-8', 08:09:20 INFO - 'LANGUAGE': 'en_US:en', 08:09:20 INFO - 'LOGNAME': 'cltbld', 08:09:20 INFO - 'MAIL': '/var/mail/cltbld', 08:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:20 INFO - 'MOZ_NO_REMOTE': '1', 08:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:20 INFO - 'NO_EM_RESTART': '1', 08:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:20 INFO - 'PWD': '/builds/slave/test', 08:09:20 INFO - 'SHELL': '/bin/bash', 08:09:20 INFO - 'SHLVL': '1', 08:09:20 INFO - 'TERM': 'linux', 08:09:20 INFO - 'TMOUT': '86400', 08:09:20 INFO - 'USER': 'cltbld', 08:09:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:20 INFO - '_': '/tools/buildbot/bin/python'} 08:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:21 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 08:09:21 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 08:09:21 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 08:09:21 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 08:09:21 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 08:09:21 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 08:09:23 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 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 08:09:23 INFO - Downloading docopt-0.6.1.tar.gz 08:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:23 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:23 INFO - Running setup.py install for blobuploader 08:09:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:23 INFO - Running setup.py install for requests 08:09:24 INFO - Running setup.py install for docopt 08:09:24 INFO - Successfully installed blobuploader requests docopt 08:09:24 INFO - Cleaning up... 08:09:24 INFO - Return code: 0 08:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:24 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 08:09:24 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 08:09:24 INFO - Using env: {'DISPLAY': ':0', 08:09:24 INFO - 'HOME': '/home/cltbld', 08:09:24 INFO - 'LANG': 'en_US.UTF-8', 08:09:24 INFO - 'LANGUAGE': 'en_US:en', 08:09:24 INFO - 'LOGNAME': 'cltbld', 08:09:24 INFO - 'MAIL': '/var/mail/cltbld', 08:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:24 INFO - 'MOZ_NO_REMOTE': '1', 08:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:24 INFO - 'NO_EM_RESTART': '1', 08:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:24 INFO - 'PWD': '/builds/slave/test', 08:09:24 INFO - 'SHELL': '/bin/bash', 08:09:24 INFO - 'SHLVL': '1', 08:09:24 INFO - 'TERM': 'linux', 08:09:24 INFO - 'TMOUT': '86400', 08:09:24 INFO - 'USER': 'cltbld', 08:09:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:24 INFO - '_': '/tools/buildbot/bin/python'} 08:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:24 INFO - Running setup.py (path:/tmp/pip-6mTy6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:24 INFO - Running setup.py (path:/tmp/pip-zpECL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:24 INFO - Running setup.py (path:/tmp/pip-kv8cji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:24 INFO - Running setup.py (path:/tmp/pip-ck0wW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:24 INFO - Running setup.py (path:/tmp/pip-5cqw14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:24 INFO - Running setup.py (path:/tmp/pip-wC7V0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:25 INFO - Running setup.py (path:/tmp/pip-zuvYx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:25 INFO - Running setup.py (path:/tmp/pip-AxO8BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:25 INFO - Running setup.py (path:/tmp/pip-dycB6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:25 INFO - Running setup.py (path:/tmp/pip-gHfRRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:25 INFO - Running setup.py (path:/tmp/pip-okUlHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:25 INFO - Running setup.py (path:/tmp/pip-BIsekl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:25 INFO - Running setup.py (path:/tmp/pip-BqSSe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:25 INFO - Running setup.py (path:/tmp/pip-ITAuO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:25 INFO - Running setup.py (path:/tmp/pip-y8PJK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:25 INFO - Running setup.py (path:/tmp/pip-J0epb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:25 INFO - Running setup.py (path:/tmp/pip-tFX6dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:25 INFO - Running setup.py install for manifestparser 08:09:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:25 INFO - Running setup.py install for mozcrash 08:09:26 INFO - Running setup.py install for mozdebug 08:09:26 INFO - Running setup.py install for mozdevice 08:09:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozfile 08:09:26 INFO - Running setup.py install for mozhttpd 08:09:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozinfo 08:09:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozInstall 08:09:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozleak 08:09:26 INFO - Running setup.py install for mozlog 08:09:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for moznetwork 08:09:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozprocess 08:09:27 INFO - Running setup.py install for mozprofile 08:09:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Running setup.py install for mozrunner 08:09:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Running setup.py install for mozscreenshot 08:09:27 INFO - Running setup.py install for moztest 08:09:27 INFO - Running setup.py install for mozversion 08:09:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:27 INFO - Cleaning up... 08:09:27 INFO - Return code: 0 08:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:27 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 08:09:27 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 08:09:27 INFO - Using env: {'DISPLAY': ':0', 08:09:27 INFO - 'HOME': '/home/cltbld', 08:09:27 INFO - 'LANG': 'en_US.UTF-8', 08:09:27 INFO - 'LANGUAGE': 'en_US:en', 08:09:27 INFO - 'LOGNAME': 'cltbld', 08:09:27 INFO - 'MAIL': '/var/mail/cltbld', 08:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:27 INFO - 'MOZ_NO_REMOTE': '1', 08:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:27 INFO - 'NO_EM_RESTART': '1', 08:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:27 INFO - 'PWD': '/builds/slave/test', 08:09:27 INFO - 'SHELL': '/bin/bash', 08:09:27 INFO - 'SHLVL': '1', 08:09:27 INFO - 'TERM': 'linux', 08:09:27 INFO - 'TMOUT': '86400', 08:09:27 INFO - 'USER': 'cltbld', 08:09:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:27 INFO - '_': '/tools/buildbot/bin/python'} 08:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:27 INFO - Running setup.py (path:/tmp/pip-FUSVlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:27 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)) 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:27 INFO - Running setup.py (path:/tmp/pip-7kGyc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:27 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)) 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:27 INFO - Running setup.py (path:/tmp/pip-kAgq2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:28 INFO - Running setup.py (path:/tmp/pip-Z52_Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:28 INFO - Running setup.py (path:/tmp/pip-gXjmkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:28 INFO - Running setup.py (path:/tmp/pip-GLhMEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:28 INFO - Running setup.py (path:/tmp/pip-xkWKpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:28 INFO - Running setup.py (path:/tmp/pip-vBcrWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:28 INFO - Running setup.py (path:/tmp/pip-qYPJI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:28 INFO - Running setup.py (path:/tmp/pip-QPBA_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:28 INFO - Running setup.py (path:/tmp/pip-l11f15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:28 INFO - Running setup.py (path:/tmp/pip-_CDdcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:28 INFO - Running setup.py (path:/tmp/pip-ax5inB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:28 INFO - Running setup.py (path:/tmp/pip-dLJ6lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:28 INFO - Running setup.py (path:/tmp/pip-DN5AP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:28 INFO - Running setup.py (path:/tmp/pip-hQl3os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:29 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)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:29 INFO - Running setup.py (path:/tmp/pip-8Qi8Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:29 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)) 08:09:29 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)) 08:09:29 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)) 08:09:29 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)) 08:09:29 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)) 08:09:29 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)) 08:09:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:29 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 08:09:29 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 08:09:29 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 08:09:29 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 08:09:29 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 08:09:29 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 08:09:30 INFO - Downloading blessings-1.6.tar.gz 08:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:31 INFO - Installing collected packages: blessings 08:09:31 INFO - Running setup.py install for blessings 08:09:31 INFO - Successfully installed blessings 08:09:31 INFO - Cleaning up... 08:09:31 INFO - Return code: 0 08:09:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:31 INFO - Reading from file tmpfile_stdout 08:09:31 INFO - Current package versions: 08:09:31 INFO - argparse == 1.2.1 08:09:31 INFO - blessings == 1.6 08:09:31 INFO - blobuploader == 1.2.4 08:09:31 INFO - docopt == 0.6.1 08:09:31 INFO - manifestparser == 1.1 08:09:31 INFO - mozInstall == 1.12 08:09:31 INFO - mozcrash == 0.17 08:09:31 INFO - mozdebug == 0.1 08:09:31 INFO - mozdevice == 0.48 08:09:31 INFO - mozfile == 1.2 08:09:31 INFO - mozhttpd == 0.7 08:09:31 INFO - mozinfo == 0.9 08:09:31 INFO - mozleak == 0.1 08:09:31 INFO - mozlog == 3.1 08:09:31 INFO - moznetwork == 0.27 08:09:31 INFO - mozprocess == 0.22 08:09:31 INFO - mozprofile == 0.28 08:09:31 INFO - mozrunner == 6.11 08:09:31 INFO - mozscreenshot == 0.1 08:09:31 INFO - mozsystemmonitor == 0.0 08:09:31 INFO - moztest == 0.7 08:09:31 INFO - mozversion == 1.4 08:09:31 INFO - psutil == 3.1.1 08:09:31 INFO - requests == 1.2.3 08:09:31 INFO - wsgiref == 0.1.2 08:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:31 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')]} 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 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')]} 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:31 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 08:09:31 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 08:09:31 INFO - Using env: {'DISPLAY': ':0', 08:09:31 INFO - 'HOME': '/home/cltbld', 08:09:31 INFO - 'LANG': 'en_US.UTF-8', 08:09:31 INFO - 'LANGUAGE': 'en_US:en', 08:09:31 INFO - 'LOGNAME': 'cltbld', 08:09:31 INFO - 'MAIL': '/var/mail/cltbld', 08:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:31 INFO - 'MOZ_NO_REMOTE': '1', 08:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:31 INFO - 'NO_EM_RESTART': '1', 08:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:31 INFO - 'PWD': '/builds/slave/test', 08:09:31 INFO - 'SHELL': '/bin/bash', 08:09:31 INFO - 'SHLVL': '1', 08:09:31 INFO - 'TERM': 'linux', 08:09:31 INFO - 'TMOUT': '86400', 08:09:31 INFO - 'USER': 'cltbld', 08:09:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:31 INFO - '_': '/tools/buildbot/bin/python'} 08:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 INFO - Cleaning up... 08:09:31 INFO - Return code: 0 08:09:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:31 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')]} 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 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')]} 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:31 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 08:09:31 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 08:09:31 INFO - Using env: {'DISPLAY': ':0', 08:09:31 INFO - 'HOME': '/home/cltbld', 08:09:31 INFO - 'LANG': 'en_US.UTF-8', 08:09:31 INFO - 'LANGUAGE': 'en_US:en', 08:09:31 INFO - 'LOGNAME': 'cltbld', 08:09:31 INFO - 'MAIL': '/var/mail/cltbld', 08:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:31 INFO - 'MOZ_NO_REMOTE': '1', 08:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:31 INFO - 'NO_EM_RESTART': '1', 08:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:31 INFO - 'PWD': '/builds/slave/test', 08:09:31 INFO - 'SHELL': '/bin/bash', 08:09:31 INFO - 'SHLVL': '1', 08:09:31 INFO - 'TERM': 'linux', 08:09:31 INFO - 'TMOUT': '86400', 08:09:31 INFO - 'USER': 'cltbld', 08:09:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:31 INFO - '_': '/tools/buildbot/bin/python'} 08:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:31 INFO - Downloading/unpacking jsonschema 08:09:31 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 08:09:31 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 08:09:31 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 08:09:31 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 08:09:31 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 08:09:31 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 08:09:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:33 INFO - Downloading/unpacking functools32 (from jsonschema) 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:34 INFO - warning: no files found matching '*.txt' 08:09:34 INFO - no previously-included directories found matching 'build' 08:09:34 INFO - no previously-included directories found matching 'dist' 08:09:34 INFO - no previously-included directories found matching '.git*' 08:09:34 INFO - Installing collected packages: jsonschema, functools32 08:09:34 INFO - Running setup.py install for functools32 08:09:34 INFO - warning: no files found matching '*.txt' 08:09:34 INFO - no previously-included directories found matching 'build' 08:09:34 INFO - no previously-included directories found matching 'dist' 08:09:34 INFO - no previously-included directories found matching '.git*' 08:09:34 INFO - Successfully installed jsonschema functools32 08:09:34 INFO - Cleaning up... 08:09:34 INFO - Return code: 0 08:09:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:34 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 0x7fe2fb7f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a345a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, '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': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', '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 08:09:34 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 08:09:34 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 08:09:34 INFO - Using env: {'DISPLAY': ':0', 08:09:34 INFO - 'HOME': '/home/cltbld', 08:09:34 INFO - 'LANG': 'en_US.UTF-8', 08:09:34 INFO - 'LANGUAGE': 'en_US:en', 08:09:34 INFO - 'LOGNAME': 'cltbld', 08:09:34 INFO - 'MAIL': '/var/mail/cltbld', 08:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:34 INFO - 'MOZ_NO_REMOTE': '1', 08:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:34 INFO - 'NO_EM_RESTART': '1', 08:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:34 INFO - 'PWD': '/builds/slave/test', 08:09:34 INFO - 'SHELL': '/bin/bash', 08:09:34 INFO - 'SHLVL': '1', 08:09:34 INFO - 'TERM': 'linux', 08:09:34 INFO - 'TMOUT': '86400', 08:09:34 INFO - 'USER': 'cltbld', 08:09:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:34 INFO - '_': '/tools/buildbot/bin/python'} 08:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:34 INFO - Downloading/unpacking flake8 08:09:34 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 08:09:34 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 08:09:34 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 08:09:34 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 08:09:34 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 08:09:34 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 08:09:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:37 INFO - no previously-included directories found matching 'docs/_build' 08:09:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:37 INFO - Running setup.py install for pep8 08:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:37 INFO - no previously-included directories found matching 'docs/_build' 08:09:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:37 INFO - Cleaning up... 08:09:37 INFO - Return code: 0 08:09:37 INFO - Running post-action listener: _resource_record_post_action 08:09:37 INFO - Running post-action listener: _start_resource_monitoring 08:09:37 INFO - Starting resource monitoring. 08:09:37 INFO - ##### 08:09:37 INFO - ##### Finished create-virtualenv step (success) 08:09:37 INFO - ##### 08:09:37 INFO - ##### 08:09:37 INFO - ##### Running install step. 08:09:37 INFO - ##### 08:09:37 INFO - Running pre-action listener: _resource_record_pre_action 08:09:37 INFO - Running main action method: install 08:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:37 INFO - Reading from file tmpfile_stdout 08:09:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:37 INFO - Reading from file tmpfile_stdout 08:09:37 INFO - Output received: 08:09:37 INFO - Usage: mozinstall [options] installer 08:09:37 INFO - Options: 08:09:37 INFO - -h, --help show this help message and exit 08:09:37 INFO - -d DEST, --destination=DEST 08:09:37 INFO - Directory to install application into. [default: 08:09:37 INFO - "/builds/slave/test"] 08:09:37 INFO - --app=APP Application being installed. [default: firefox] 08:09:37 INFO - mkdir: /builds/slave/test/build/application 08:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:09:54 INFO - Reading from file tmpfile_stdout 08:09:54 INFO - Output received: 08:09:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:09:54 INFO - Running post-action listener: _resource_record_post_action 08:09:54 INFO - ##### 08:09:54 INFO - ##### Finished install step (success) 08:09:54 INFO - ##### 08:09:54 INFO - ##### 08:09:54 INFO - ##### Running run-tests step. 08:09:54 INFO - ##### 08:09:54 INFO - Running pre-action listener: _resource_record_pre_action 08:09:54 INFO - Running main action method: run_tests 08:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:09:54 INFO - Python 2.7.3 08:09:54 INFO - Return code: 0 08:09:54 INFO - grabbing minidump binary from tooltool 08:09:54 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')]} 08:09:54 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 0x2ac3410>, '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 0x2ac4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:09:54 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 08:09:54 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 08:09:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:54 INFO - Return code: 0 08:09:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:09:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:09:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:09:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:09:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:09:55 INFO - Return code: 0 08:09:55 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/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 08:09:55 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/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 08:09:55 INFO - Using env: {'DISPLAY': ':0', 08:09:55 INFO - 'HOME': '/home/cltbld', 08:09:55 INFO - 'LANG': 'en_US.UTF-8', 08:09:55 INFO - 'LANGUAGE': 'en_US:en', 08:09:55 INFO - 'LOGNAME': 'cltbld', 08:09:55 INFO - 'MAIL': '/var/mail/cltbld', 08:09:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:09:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:55 INFO - 'MOZ_NO_REMOTE': '1', 08:09:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:55 INFO - 'NO_EM_RESTART': '1', 08:09:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:55 INFO - 'PWD': '/builds/slave/test', 08:09:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:09:55 INFO - 'SHELL': '/bin/bash', 08:09:55 INFO - 'SHLVL': '1', 08:09:55 INFO - 'TERM': 'linux', 08:09:55 INFO - 'TMOUT': '86400', 08:09:55 INFO - 'USER': 'cltbld', 08:09:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462546688.476896-1627948680', 08:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:55 INFO - '_': '/tools/buildbot/bin/python'} 08:09:55 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/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 08:09:55 INFO - mozversion application_buildid: 20160506052037 08:09:55 INFO - mozversion application_changeset: 19a1743ceb2e035e571012e88d25275ce627b925 08:09:55 INFO - mozversion application_display_name: Nightly 08:09:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:55 INFO - mozversion application_name: Firefox 08:09:55 INFO - mozversion application_remotingname: firefox 08:09:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:09:55 INFO - mozversion application_vendor: Mozilla 08:09:55 INFO - mozversion application_version: 49.0a1 08:09:55 INFO - mozversion platform_buildid: 20160506052037 08:09:55 INFO - mozversion platform_changeset: 19a1743ceb2e035e571012e88d25275ce627b925 08:09:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:09:55 INFO - mozversion platform_version: 49.0a1 08:09:55 INFO - using testdate: 1462547395 08:09:55 INFO - actual date: 1462547395 08:09:55 INFO - starting webserver on 'localhost:32958' 08:09:55 INFO - SUITE-START | Running 2 tests 08:09:55 INFO - TEST-START | dromaeo_css 08:09:55 INFO - operating with platform_type : linux_ 08:09:55 INFO - Initialising browser for dromaeo_css test... 08:09:55 INFO - TEST-INFO | started process 32429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuX2RXF/profile http://localhost:32958/getInfo.html) 08:09:59 INFO - PROCESS | 32429 | 08:09:59 INFO - PROCESS | 32429 | (process:32496): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:10:00 INFO - PROCESS | 32429 | __metrics Screen width/height:1600/1200 08:10:00 INFO - PROCESS | 32429 | colorDepth:24 08:10:00 INFO - PROCESS | 32429 | Browser inner width/height: 1024/697 08:10:00 INFO - PROCESS | 32429 | __metrics 08:10:00 ERROR - PROCESS | 32429 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:10:01 INFO - TEST-INFO | 32429: exit 0 08:10:01 INFO - Browser initialized. 08:10:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:01 INFO - TEST-INFO | started process 32547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuX2RXF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:03 INFO - PROCESS | 32547 | 08:10:03 INFO - PROCESS | 32547 | (process:32609): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:10:13 INFO - PROCESS | 32547 | RSS: Main: 163270656 08:10:13 INFO - PROCESS | 32547 | 08:11:03 INFO - PROCESS | 32547 | 1462547463113 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] 08:13:10 INFO - PROCESS | 32547 | Cycle 1(1): loaded http://localhost:32958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32958/tests/dromaeo/cssquery-ext.html) 08:13:11 INFO - PROCESS | 32547 | RSS: Main: 167419904 08:13:11 INFO - PROCESS | 32547 | 08:16:13 INFO - PROCESS | 32547 | Cycle 1(1): loaded http://localhost:32958/tests/dromaeo/cssquery-ext.html (next: http://localhost:32958/tests/dromaeo/cssquery-jquery.html) 08:16:14 INFO - PROCESS | 32547 | RSS: Main: 166887424 08:16:14 INFO - PROCESS | 32547 | 08:19:16 INFO - PROCESS | 32547 | Cycle 1(1): loaded http://localhost:32958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32958/tests/dromaeo/cssquery-mootools.html) 08:19:16 INFO - PROCESS | 32547 | RSS: Main: 167940096 08:19:16 INFO - PROCESS | 32547 | 08:22:18 INFO - PROCESS | 32547 | Cycle 1(1): loaded http://localhost:32958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32958/tests/dromaeo/cssquery-prototype.html) 08:22:19 INFO - PROCESS | 32547 | RSS: Main: 165892096 08:22:19 INFO - PROCESS | 32547 | 08:25:21 INFO - PROCESS | 32547 | Cycle 1(1): loaded http://localhost:32958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32958/tests/dromaeo/cssquery-yui.html) 08:25:22 INFO - PROCESS | 32547 | RSS: Main: 167108608 08:25:22 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | Cycle 1(1): loaded http://localhost:32958/tests/dromaeo/cssquery-yui.html (next: http://localhost:32958/tests/dromaeo/cssquery-dojo.html) 08:28:24 INFO - PROCESS | 32547 | RSS: Main: 168869888 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | __start_tp_report 08:28:24 INFO - PROCESS | 32547 | _x_x_mozilla_page_load 08:28:24 INFO - PROCESS | 32547 | _x_x_mozilla_page_load_details 08:28:24 INFO - PROCESS | 32547 | |i|pagename|runs| 08:28:24 INFO - PROCESS | 32547 | |0;dojo.html;3183.1246407238004;3185.554022436858;3191.92020199495;3219.2112932331584;3246.853891574879;5487.451254874515;5517.144842549406;5520.47555482229;5592.245046918665;5634.605577609559;5447.101228297336;5560.582956278275;5586.972065139679;5598.580106492009;5610.579206559504;4989.975050124763;5003.524665156822;5139.897202055957;5165.431802501741;5200.843974680765;853.0865669898091;4930.359053323063;5030.144875371196;5082.593392528589;5147.845564633067;5017.422996355429;5020.7489625518765;5059.6964182149;5061.038402703474;5068.34111565496;5065.569426598743;5075.568576670988;5075.5939524838295;5075.822346217901;5097.13348730713;4980.153373926441;4985.52637499437;5009.899802003976;5026.170681837492;5050.696958182521;5412;5479.369872464637;5483.945160548423;5487.451254874521;5551.8889622207325;5724.026915424388;5899.616524925866;5903.0555111182;5923.496502797268;5942.435468630473;5950.375210602911;6022.3676513966275;6037.969810150965;6072.908906366408;6100.115483254947;5602.971985140089;5607.467290607427;5623.606347555673;5627.662340259598;5632.014397480424;5945.791897283574;6014.127951447103;6057.878842423127;6153.2000839890525;6165.691715414211;5732.971335143297;5736.885262294814;5741.45456181662;5747.511461525817;5760;5895.616784908967;5903;5909.5863289569315;5921.111833225051;5928.140419639129;5872.941270587239;5921.851953701192;5937.465628093492;5984.551158663117;5991.191189189491;5963.522918166536;5972.641641501524;6005.759769609254;6013.368596297413;6014.729337179838;4419.469663640384;4503.864884053483;4515.2324104902245;4523.2988886722615;4531.501534831166;3882.281777871103;3963.4451176835264;3976.1053762903693;4011;4024.4566983456857;5626.97186514073;5642.7178641067785;5697.173909783141;5713.657180569179;5715.657060576379;5882.058870580687;5995.160677505153;6004.669743164168;6007.249093863267;6014.578979471483;5693.516051135617;5715.657060576379;5739.713014349266;5755.280589926259;5785.8553536161935;5133.768980395891;5157.8452646420665;5159.071367153873;5172.456892026358;5175.094358487249;5995.490383317467;6107.037103281039;6249.468795152463;6260.154879091265;6263.843403914939;6005.939940600538;6067.059605761114;6072.666003369857;6074.605150665193;6115.7247923844425;6148.262208535004;6149.723262453111;6172.783952561639;6181.134641150153;6225.844353891189;5602.607817452739;5639.774409023593;5652.095664693629;5922.052471604523;5927.4665280125;5740.741666624928;5782.884342313214;5787.189793429007;5791.565632577489;5847.94152058474;5558.694271815089;5562.833115006556;5564.944350556442;5569.526590239713;5624.240727501735;5548.056830338772;5574;5705.087186050212;5779.624324418899;5807.303123625192;5647.407022262768;5679.943200567942;5680.11958146488;5711.543076553949;5714.20001199824;5825.79609713658;5862.560307977004;5863.589548731547;5889.646621202742;5907.084401917709;5570.888582228414;5712.857178570569;5714.342850572071;5746.511546518593;5758.884822303614 08:28:24 INFO - PROCESS | 32547 | |1;ext.html;599.7121381736766;656.3961155736722;659.3571268013684;670.2158474584735;694.2987582541631;38943.415848762255;39725;42681.359779603255;42688.14623707524;42765.57234427659;44956;45027.324590131175;45385;45391;45396.3190552142;8951.597178127;9118.17936385725;9123.635054597808;9128.315376346767;9131.954340228323;8927.285817134614;9052.049534798816;9068.455892646429;9074.77313067172;9075.41009834362;9130.863037054449;9142.634294628207;9152.4966126863;9163.08369163085;9184.173424391804;9013.32400069994;9065.41074830134;9094.954525227398;9103;9112;8973.910260897437;9049.864252036225;9061.954690226572;9068.229200517964;9074.500902450363;34865.30269394598;42131.368029479585;42220.78889605563;42371.57628423707;42515.787421063;3430.382531144393;3562.251927095313;3584.426491761306;3680.0799800049986;3694.5012423323046;30713.69286307131;31315.217119571964;31321.686783132332;31431.842840785648;32506;4095.201435720036;4284.207421627009;4320.416743739618;4324.178406102862;4381.145676593065;320421;320572;321423;322533;324794;35511.64488355135;63332.683336583024;64131;64261.67869160718;64524;36065.278694425964;37910.81044594815;37948.62051379506;38064.42903356452;38119.428208576894;16118.516444506684;16169;16262.837371626132;16312.836871631369;16322.102284374474;13664.590062298146;13721.313934303245;13734.381952812148;13748.93125534366;13835.30823458823;8750.47497150173;8766.91233087661;8791.780205494913;8816.250618697482;8832.602532886036;3324.634290228073;3340.3820293245826;3366.562346894888;3379.4930760385646;3405.404054290489;1080.6271836216492;1121.388843080523;1128.8588926384202;1158.6060739348493;1187.9486654310824;32702.509462358084;33021;33192.66807331896;34055.82972085124;34087.488687669706;1148.1331594646156;1159.8956093951585;1176.6764139861607;1182.586094866807;1244.8817362350744;16746.581335466468;16845.410410635814;16954.576135596708;17068.573285667957;17122.657546848994;498042;500173;502244;504012;505376;57854;59113.70443147757;59168.704156479806;59257.70371148117;59379.40620593739;1423.2812429722717;1434.483585909072;1437.6334034821264;1444.3861358922627;1444.9422023118957;30179.762510095097;31179.53230701496;31207;31497.527537086502;32133.35733285368;52199.73900130475;52797;53594.19608705794;53626.73186634042;53832.73083634557;352479;352836;354561;356053;357131;28918.855405722836;29181.270468238465;29248.707512925448;29324;29596.704032959395;48955.26567101567;49930.75034624804;50377.74811125921;50507.494925050276;50537;41205.793971029954;42142.57857421387;42525.5747442534;42687.57312426836;42770.144597108505;40853.79573102116;41560.58439415688;41611.37582936319;42083.53026044153;43082.56917430911;43497.56502434935;44150.33774493321;45884.31173532466;47023.52976470192;47419.76290118528;38741.2251754969;42513.90169199223;42859.57140428556;42924.14151717011;42943.7852810734;33861.830690846386;33936.66063339335;33994;34047;34638.653613463546 08:28:24 INFO - PROCESS | 32547 | |2;jquery.html;389.7602974170884;395.12676983865657;398.219489799992;400.59139677528924;412.8575641403715;13729.313534323293;17808;18482.44552663419;19619.5095122622;19679.311224107158;18620.72068918964;18653.25386984519;19145.904270478663;19412.805871941277;19420.611587768235;5635.520980716634;5670.8015219467325;5711.543556393135;5731.455511726379;5825.679587622679;5667.433256674341;5696.316442026962;5699.116636921284;5745.511631511326;5754.884902301951;5388.164834450647;5677.148427735831;5678.346990096151;5691.08942569189;5704.34400043994;5622.240997465351;5651;5696.145578163288;5848.41515848416;6320.968395157995;5715.342735585419;5753.827385178452;5790.855228619276;5793.507551858097;5821.18503409523;20144.79855201444;21305.786942130537;22338.441538961495;22357.55284894293;22436.775632243633;2246.831487638434;2247.685324054634;2344.542814151241;2364.0898254172093;2940.5736168255485;10197.439140847251;10205.87735349111;10303.948480257552;10306.175505959505;10631.84052239217;1871.2982631513182;1878.0985127138913;1892.0823400650672;1907.294301108585;1922.1158267197106;72898;75317.24682753158;76580.23419765843;77710;81917.59041204816;10388.48057597117;10695.465226738632;10764.515596798163;10918.890811091787;11008.834867476995;15399.538013859603;15420.84579154194;15445.613859653598;15518.84481155174;15539.611509712347;8061.919380806117;8282.8343433131;8328.750137495885;8375.288100511403;8416.074231834617;8050.11448740638;8108.797280068045;8114;8176.3458923286;8267.29727973129;4621.168189725881;4691.882702932386;4737.881552961135;4762.904741905142;4805.486271824364;1922.2036477955926;1930.362980216525;1992.4819546917906;1996.2913165826212;2049.1803278688644;992.265723364705;1043.3844032021143;1054.541274545575;1054.715226888751;1148.9195756297147;18694.906525467286;19277.51806204828;19449.4165175045;19505.707414388795;19713.901430492755;1054.3568423261804;1072.9034386905216;1075.1237741240864;1082.1396989393452;1086.7772106718103;10692.411917344622;11105.278156919774;11126.332420054823;11168.162387820947;11208.607698730668;533895;534779;536906;538186;542005;84231.5788421054;96592.51703741578;97794;98502.5074874621;102332;495.0988205291697;496.9353983982059;518.264065027654;519.1926554208167;522.4357693690805;10614.575416983234;10702.839457408301;10810.135189185004;10927.180461465581;11056.723581910195;41108.58891411167;41394.844748105046;41473.37789933093;41662.791686041375;42533;59505.53708471795;59548;61125;61151.38848611457;62388.688056559426;8517.787055323666;8683.198541072064;8756.912430875609;8773.912260877565;8801.823963520821;12807.61577152687;13256.801147982595;13416.329183540589;13554.525591604246;13879.167249965034;11663.24188927717;11984.880151198726;12005.219660722025;12049.397530123633;12049.578264760692;8571.871421928552;11644.301341919512;11724.648260552198;11760.88239117598;11843.28940263587;11956.461959211681;11956.641300760992;12016.939915300367;12027.15809893299;12056.578019769266;8873.689420870238;8980.550972451481;9016.549172541478;9046.728598142066;9063.637454501746;8466.534340611079;10882.891171088188;11732.178747487595;11776.352300623548;11851.585194518151 08:28:24 INFO - PROCESS | 32547 | |3;mootools.html;1513.303880215101;1561.69546938347;1700.70237708401;1816.6729988602056;1822.7812662480505;7683.846323073535;8318.667253309868;8392.958035209815;8895;8905.732828015161;8464.576771161433;8736.432131911437;8792.604332805024;8813.823723525526;8826.073262307462;2230.431240033789;2259.8757068361233;2262.366537369539;2265.2977576951116;2275.2719129878446;2211.889405529717;2221.9777802222015;2250.3024062540585;2262.671912572676;2265.8640481571074;2243.2597242909883;2253.43664083979;2256.199049337486;2264.501809601885;2272.943176420594;2205.757366689663;2209.7458792238936;2209.845310828243;2217.689523466716;2218.8335874809372;2169.4684802223396;2213.103693004336;2215.3464727905143;2224.63293556563;2302.919397821085;8672.696455624024;8684.2618377438;8690.956545217297;8733.563321833883;8742.213200811957;5177.508136727042;5301.416844147141;5342.706151161685;5351.678899266057;5353.277307563507;3361.5461912641726;3478.0783092480515;3541.9645803541894;3595.46068089786;3615.7468977171607;1172.6657902497832;1180.8405865208174;1209.0750575809514;1219.9451024703822;1244.975100497985;11751.588694395656;11787.469563869561;11824.11319151067;11838.230515016583;11874.465649045727;4709.95290047102;4815.133276010351;4902.7058376497525;4918.188498897642;4958.776855041532;10067.244956628283;10096.091351778228;10127.088562029452;10145.08694217524;10180.134688551409;5504.779808807683;5539.41836107211;5547.694876781816;5563;5563.304586926634;4359.847405340861;4849.563539281411;4964.702117872939;4989.351384320015;5099.59203263738;4001.9599804001587;4023.2959232134845;4106.815193316308;4111.732737372061;4264.616184543406;1270.4727538071782;1296.4749276542827;1301.2322729589587;1311.4229738914846;1321.062045947369;985.2315194148575;988.1699372527112;993.8558908958305;1003.6085926488676;1013.7871047080196;5960.344362120163;5992.730327135289;6025.969870150709;6054.091886217015;6085.661154546081;452.9524399937959;455.02851412235117;461.68374663355706;462.0182113009854;464.1181754666094;4043.3126368517424;4176.916461670749;4220.873373798791;4227.809748561261;4246.766427846436;10586.629467968738;10878.619248326271;10978.066864316623;11006.779864402668;11022.50398732043;10136.797264054825;10649;10731.356118632906;10920.235583509078;10974.012338889539;8238.794030149174;8456.661733530713;8495.1080136586;8501.787455313666;8512.40413171072;5927.110933360031;6074.635521868702;6155.630662160284;6219.626822390671;6224.813255602339;10258.384496930208;10478.790424191626;10499.632512862014;10615.256932014685;10691.358518488916;10014.19886409071;10516;10536.473176341306;10539.63111291101;10640.521176547229;7084.822879428056;7432.885067239958;7619.238076192337;7698.230176982257;7897.328727058264;8556.871646925176;8631.654733810577;8654.134586541548;8661.177188167114;8665.566721664018;7496;7681.9231807683445;7739.883901741591;7884.921150788648;7925.28672419462;7473.327400533978;7745.65144568507;7754.922450775645;7815.335696465864;7818.530888146502;6850.45196384298;6900.6204658744255;6931.722731090902;6938.132733408324;6944.722211111499;4864.391951006124;4926.802927882844;5033.697978121324;5130.281760553451;5150.690958542499;4832.879178020437;4982.128127577587;5114.258432527188;5132.7433628317685;5147.639665223398 08:28:24 INFO - PROCESS | 32547 | |4;prototype.html;337.75175246194044;339.30442592684994;342.88856121760426;349.6136768870397;350.85614897891867;5591.189277554758;5664.688442135691;5688.829335119948;5695.889301586192;5721.456461636149;5615.382307946123;5616.831495055145;5617.4382561743805;5630.5495560355175;5653.830385088444;4149.1701659668115;4278.8502402415925;4356.934645980313;4357.869263922087;4358.368036634702;4340.544242854502;4356.803943822536;4361.538884473689;4378.2775841986195;4392.450943632046;4286.207051695431;4313.805878735465;4321.416608757809;4334.783260836962;4335.393044973691;4182.7281226720315;4268.018355778173;4269.765162916038;4283.164782867342;4292.248856450109;3772.792496412696;3777.2823163599105;3783.356829339019;3795.905102372435;3824.770513769155;5304.761285742151;5365.973170134124;5371.409144994048;5458.235846981426;5479.4520547945285;4931.827386041507;4992.301077849104;5006.549410553068;5019.4227663818765;5032.874178145539;5774.913376299359;5826.417358264182;5827.300723913115;5839.211706419622;5847.152162936351;4179.310413781723;4205.789710514493;4211.284081706087;4214.220369231672;4221.176870510251;5802.448767367094;6001;6024.156618073517;6024.258962172201;6060.484858787008;4258.978705106455;4268.765217913045;4272.359146128106;4309.310510318334;4312.805923733439;4319.136172765397;4353.238183317907;4358.363190269904;4388.210122178039;4415.315626077963;4826.831060912851;4939.506049395103;4946.826861059845;4960.379952505937;4984.8753781155765;5820.3888591698105;5822.748109156551;5827.4172582741385;5891.911621325684;5891.941080589139;1458.2125652147934;1466.8459811719829;1470.3089547912464;1473.9705205896037;1479.1199236454293;978.5645387802359;1006.1699098243978;1024.59528486249;1025.646152077532;1027.8796112237546;5398.217258497496;5421.701806400607;5461.754221060062;5466.671999680032;5481.835544933659;5784.4504772046585;5792.9420705793245;5793.478586927196;5832.287986086405;5833.358330583633;5329;5369.6509726867625;5609.943900560942;5684.545236381162;5705.1727499512335;3107.4717298059386;3119.173419043955;3160.920976975594;3201;3208.2300247940793;5802.303723553201;6099.420555047263;6106.267247930276;6133.478654314434;6262.5929314594405;6176.845578860564;6177.413145751147;6194.783182588588;6207.255129384503;6208.81373558794;6146.754129834757;6227;6281.434670879643;6296.527760417987;6300.527460440485;5892.175095486549;6023.819285421444;6030.7636934427455;6124.785632502841;6128.479079278133;6064.787732429344;6087.421694938974;6101.572889897665;6110.541709371726;6113.694315284307;6090.482309003607;6270.905936410866;6317.368263173829;6317.4630156437215;6345.303246120473;4260.233158031584;4295.742255464682;4298.140371925565;4301.419308393452;4309.547497512716;5743.253377060955;5873.207117039145;6072.939270607414;6096.725647345791;6142.416470435302;5835.649861008353;5840.591158618856;5887.911681324869;5908.586398952032;5910.320313164041;5691.658500489983;5856.267966504187;5871.412858714265;5888;5890.879283457866;5695.8860822784145;5696.1455781633085;5696.259486266758;5697.20538030519;5727.5417966561745;5905.527557795452;5915.40845915405;5942.6731529766275;5971.970140149271;5973.880522389615;5620.18507316445;5751.769929202785;5789.218455508452;5791.681457519877;5801.6519008859605 08:28:24 INFO - PROCESS | 32547 | |5;yui.html;784.2040329065999;846.9449485783424;864.9740507784765;866.1381924984637;878.1657425445828;14224.644383890409;14513.854861451382;14582.343794529244;14608.561743147697;14730.63173420665;11848.407579621027;13806.378712957916;13857.168569885815;13862.792058119136;13876.791848122286;825.5707032343163;845.9873101903477;846.7544412120478;847.8812966184739;847.9236868681818;844.1094645149365;848.0417128644623;848.2789628815519;848.6732607945954;852.595017366749;874.4840544078992;875.8554838451648;876.5003947749785;878.301750108662;879.0242830458186;868.4181598329135;871.0418539606445;875.5315905990265;877.5787621941504;878.9121087891224;633.100996584846;637.3721883944311;638.8243233110885;639.1722719078804;640.5228105061713;14590.854091459056;14595;14595.343209555489;14628.561143165722;14678.119312841158;13056.477740890354;13080.738385232336;13143.934280328633;13259.3370331484;13603.455861765517;11890.464929078213;11906.761864762742;11926.701832454171;12016.819747703792;12137;3890.922181556353;3900.7464514806447;3944.1520073184115;3944.2111577684577;3978.7214894957365;58057.129143062884;58504.41495585032;58546;58591.82816343692;58790.41209587892;10286.125679317192;10304.175665946706;10915.672529824118;10930.089496557055;11104.222704410613;18769.81230187708;18775.436736897915;18895;18941.81058189428;18987.905060474608;7940.960295198487;8044.839103217902;8050.154733752989;8162.14297498766;8188.877166842502;4841.394825646794;4882.389701287339;4929.852104436873;4937.061958227925;4945.2582112683385;3398.5921689397433;3520.0495866116007;3526.541549598587;3531.5938667053106;3533.858645654145;613.2181468627535;621.5276389943585;624.1760875644197;626.3986572889986;648.6529706606942;617.4412156997925;645.4965127200791;698.4552049401475;737.8118579762127;738.512581696078;8615.827683446421;8677.305815534743;8793.988691300454;8819.779505512286;8896.466212027299;646.0503060501056;655.7049327802508;708.3447810775116;717.160921721587;732.9157146928064;4168.562300958356;4383.956160438419;4402.031553058322;4450.109978004347;4455.933161002587;60687.69656151691;66593.00110498346;67275.32724672789;67292;67302.66348668226;57441.425585744444;58392;58911;59271.703641481516;60554.09168862383;54847.177292340646;55332.99999999919;55335.723321383135;55693.72153139208;56213.43786562082;8140.389470789596;8191.262786349257;8365.790855228424;8572.185642363966;8702.47785132894;34792.47811282782;34799;35430;35437.64562354344;35987.820060899525;47812.5218747822;47831;47997.28004080011;48066.5193348062;48494;11127.610533631285;11157.776844463227;11268.267562608404;11284.32294062359;11291.43542822872;12015.819762703391;12312.384380780746;12323;12343.753124937271;12419.441125149571;11707.824382634097;11856.110791690486;12378.319192444502;12631.305278209788;12647.241165530098;11622.418879056182;11675.03327534007;11762.647120586054;11882.16824822254;12034.097442691658;11523.596674116701;11528.769424611628;11626.53493860236;11779.764404712028;11828.46771895284;9384.483853388128;9451.196648284698;9464.194557195931;9588.280878933969;9598.088181622734;9960.302778805413;10143.49282535885;10266.332688375232;10282.485875706334;10326.948365258126 08:28:24 INFO - PROCESS | 32547 | __end_tp_report 08:28:24 INFO - PROCESS | 32547 | __start_cc_report 08:28:24 INFO - PROCESS | 32547 | _x_x_mozilla_cycle_collect,346 08:28:24 INFO - PROCESS | 32547 | __end_cc_report 08:28:24 INFO - PROCESS | 32547 | __startTimestamp1462548504732__endTimestamp 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | ------- Summary: start ------- 08:28:24 INFO - PROCESS | 32547 | Number of tests: 6 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | [#0] dojo.html Cycles:165 Average:5482.87 Median:5705.09 stddev:729.89 (12.8%) stddev-sans-first:709.48 08:28:24 INFO - PROCESS | 32547 | Values: 3183.1 3185.6 3191.9 3219.2 3246.9 5487.5 5517.1 5520.5 5592.2 5634.6 5447.1 5560.6 5587.0 5598.6 5610.6 4990.0 5003.5 5139.9 5165.4 5200.8 853.1 4930.4 5030.1 5082.6 5147.8 5017.4 5020.7 5059.7 5061.0 5068.3 5065.6 5075.6 5075.6 5075.8 5097.1 4980.2 4985.5 5009.9 5026.2 5050.7 5412.0 5479.4 5483.9 5487.5 5551.9 5724.0 5899.6 5903.1 5923.5 5942.4 5950.4 6022.4 6038.0 6072.9 6100.1 5603.0 5607.5 5623.6 5627.7 5632.0 5945.8 6014.1 6057.9 6153.2 6165.7 5733.0 5736.9 5741.5 5747.5 5760.0 5895.6 5903.0 5909.6 5921.1 5928.1 5872.9 5921.9 5937.5 5984.6 5991.2 5963.5 5972.6 6005.8 6013.4 6014.7 4419.5 4503.9 4515.2 4523.3 4531.5 3882.3 3963.4 3976.1 4011.0 4024.5 5627.0 5642.7 5697.2 5713.7 5715.7 5882.1 5995.2 6004.7 6007.2 6014.6 5693.5 5715.7 5739.7 5755.3 5785.9 5133.8 5157.8 5159.1 5172.5 5175.1 5995.5 6107.0 6249.5 6260.2 6263.8 6005.9 6067.1 6072.7 6074.6 6115.7 6148.3 6149.7 6172.8 6181.1 6225.8 5602.6 5639.8 5652.1 5922.1 5927.5 5740.7 5782.9 5787.2 5791.6 5847.9 5558.7 5562.8 5564.9 5569.5 5624.2 5548.1 5574.0 5705.1 5779.6 5807.3 5647.4 5679.9 5680.1 5711.5 5714.2 5825.8 5862.6 5863.6 5889.6 5907.1 5570.9 5712.9 5714.3 5746.5 5758.9 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | [#1] ext.html Cycles:180 Average:55890.81 Median:42107.45 stddev:105953.33 (251.6%) stddev-sans-first:106169.23 08:28:24 INFO - PROCESS | 32547 | Values: 599.7 656.4 659.4 670.2 694.3 38943.4 39725.0 42681.4 42688.1 42765.6 44956.0 45027.3 45385.0 45391.0 45396.3 8951.6 9118.2 9123.6 9128.3 9132.0 8927.3 9052.0 9068.5 9074.8 9075.4 9130.9 9142.6 9152.5 9163.1 9184.2 9013.3 9065.4 9095.0 9103.0 9112.0 8973.9 9049.9 9062.0 9068.2 9074.5 34865.3 42131.4 42220.8 42371.6 42515.8 3430.4 3562.3 3584.4 3680.1 3694.5 30713.7 31315.2 31321.7 31431.8 32506.0 4095.2 4284.2 4320.4 4324.2 4381.1 320421.0 320572.0 321423.0 322533.0 324794.0 35511.6 63332.7 64131.0 64261.7 64524.0 36065.3 37910.8 37948.6 38064.4 38119.4 16118.5 16169.0 16262.8 16312.8 16322.1 13664.6 13721.3 13734.4 13748.9 13835.3 8750.5 8766.9 8791.8 8816.3 8832.6 3324.6 3340.4 3366.6 3379.5 3405.4 1080.6 1121.4 1128.9 1158.6 1187.9 32702.5 33021.0 33192.7 34055.8 34087.5 1148.1 1159.9 1176.7 1182.6 1244.9 16746.6 16845.4 16954.6 17068.6 17122.7 498042.0 500173.0 502244.0 504012.0 505376.0 57854.0 59113.7 59168.7 59257.7 59379.4 1423.3 1434.5 1437.6 1444.4 1444.9 30179.8 31179.5 31207.0 31497.5 32133.4 52199.7 52797.0 53594.2 53626.7 53832.7 352479.0 352836.0 354561.0 356053.0 357131.0 28918.9 29181.3 29248.7 29324.0 29596.7 48955.3 49930.8 50377.7 50507.5 50537.0 41205.8 42142.6 42525.6 42687.6 42770.1 40853.8 41560.6 41611.4 42083.5 43082.6 43497.6 44150.3 45884.3 47023.5 47419.8 38741.2 42513.9 42859.6 42924.1 42943.8 33861.8 33936.7 33994.0 34047.0 34638.7 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | [#2] jquery.html Cycles:180 Average:30137.52 Median:2354.32 stddev:88416.23 (3755.5%) stddev-sans-first:88636.04 08:28:24 INFO - PROCESS | 32547 | Values: 389.8 395.1 398.2 400.6 412.9 13729.3 17808.0 18482.4 19619.5 19679.3 18620.7 18653.3 19145.9 19412.8 19420.6 5635.5 5670.8 5711.5 5731.5 5825.7 5667.4 5696.3 5699.1 5745.5 5754.9 5388.2 5677.1 5678.3 5691.1 5704.3 5622.2 5651.0 5696.1 5848.4 6321.0 5715.3 5753.8 5790.9 5793.5 5821.2 20144.8 21305.8 22338.4 22357.6 22436.8 2246.8 2247.7 2344.5 2364.1 2940.6 10197.4 10205.9 10303.9 10306.2 10631.8 1871.3 1878.1 1892.1 1907.3 1922.1 72898.0 75317.2 76580.2 77710.0 81917.6 10388.5 10695.5 10764.5 10918.9 11008.8 15399.5 15420.8 15445.6 15518.8 15539.6 8061.9 8282.8 8328.8 8375.3 8416.1 8050.1 8108.8 8114.0 8176.3 8267.3 4621.2 4691.9 4737.9 4762.9 4805.5 1922.2 1930.4 1992.5 1996.3 2049.2 992.3 1043.4 1054.5 1054.7 1148.9 18694.9 19277.5 19449.4 19505.7 19713.9 1054.4 1072.9 1075.1 1082.1 1086.8 10692.4 11105.3 11126.3 11168.2 11208.6 533895.0 534779.0 536906.0 538186.0 542005.0 84231.6 96592.5 97794.0 98502.5 102332.0 495.1 496.9 518.3 519.2 522.4 10614.6 10702.8 10810.1 10927.2 11056.7 41108.6 41394.8 41473.4 41662.8 42533.0 59505.5 59548.0 61125.0 61151.4 62388.7 8517.8 8683.2 8756.9 8773.9 8801.8 12807.6 13256.8 13416.3 13554.5 13879.2 11663.2 11984.9 12005.2 12049.4 12049.6 8571.9 11644.3 11724.6 11760.9 11843.3 11956.5 11956.6 12016.9 12027.2 12056.6 8873.7 8980.6 9016.5 9046.7 9063.6 8466.5 10882.9 11732.2 11776.4 11851.6 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | [#3] mootools.html Cycles:180 Average:5798.89 Median:461.85 stddev:3289.21 (712.2%) stddev-sans-first:3282.67 08:28:24 INFO - PROCESS | 32547 | Values: 1513.3 1561.7 1700.7 1816.7 1822.8 7683.8 8318.7 8393.0 8895.0 8905.7 8464.6 8736.4 8792.6 8813.8 8826.1 2230.4 2259.9 2262.4 2265.3 2275.3 2211.9 2222.0 2250.3 2262.7 2265.9 2243.3 2253.4 2256.2 2264.5 2272.9 2205.8 2209.7 2209.8 2217.7 2218.8 2169.5 2213.1 2215.3 2224.6 2302.9 8672.7 8684.3 8691.0 8733.6 8742.2 5177.5 5301.4 5342.7 5351.7 5353.3 3361.5 3478.1 3542.0 3595.5 3615.7 1172.7 1180.8 1209.1 1219.9 1245.0 11751.6 11787.5 11824.1 11838.2 11874.5 4710.0 4815.1 4902.7 4918.2 4958.8 10067.2 10096.1 10127.1 10145.1 10180.1 5504.8 5539.4 5547.7 5563.0 5563.3 4359.8 4849.6 4964.7 4989.4 5099.6 4002.0 4023.3 4106.8 4111.7 4264.6 1270.5 1296.5 1301.2 1311.4 1321.1 985.2 988.2 993.9 1003.6 1013.8 5960.3 5992.7 6026.0 6054.1 6085.7 453.0 455.0 461.7 462.0 464.1 4043.3 4176.9 4220.9 4227.8 4246.8 10586.6 10878.6 10978.1 11006.8 11022.5 10136.8 10649.0 10731.4 10920.2 10974.0 8238.8 8456.7 8495.1 8501.8 8512.4 5927.1 6074.6 6155.6 6219.6 6224.8 10258.4 10478.8 10499.6 10615.3 10691.4 10014.2 10516.0 10536.5 10539.6 10640.5 7084.8 7432.9 7619.2 7698.2 7897.3 8556.9 8631.7 8654.1 8661.2 8665.6 7496.0 7681.9 7739.9 7884.9 7925.3 7473.3 7745.7 7754.9 7815.3 7818.5 6850.5 6900.6 6931.7 6938.1 6944.7 4864.4 4926.8 5033.7 5130.3 5150.7 4832.9 4982.1 5114.3 5132.7 5147.6 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | [#4] prototype.html Cycles:180 Average:4924.15 Median:5618.81 stddev:1454.34 (25.9%) stddev-sans-first:1417.09 08:28:24 INFO - PROCESS | 32547 | Values: 337.8 339.3 342.9 349.6 350.9 5591.2 5664.7 5688.8 5695.9 5721.5 5615.4 5616.8 5617.4 5630.5 5653.8 4149.2 4278.9 4356.9 4357.9 4358.4 4340.5 4356.8 4361.5 4378.3 4392.5 4286.2 4313.8 4321.4 4334.8 4335.4 4182.7 4268.0 4269.8 4283.2 4292.2 3772.8 3777.3 3783.4 3795.9 3824.8 5304.8 5366.0 5371.4 5458.2 5479.5 4931.8 4992.3 5006.5 5019.4 5032.9 5774.9 5826.4 5827.3 5839.2 5847.2 4179.3 4205.8 4211.3 4214.2 4221.2 5802.4 6001.0 6024.2 6024.3 6060.5 4259.0 4268.8 4272.4 4309.3 4312.8 4319.1 4353.2 4358.4 4388.2 4415.3 4826.8 4939.5 4946.8 4960.4 4984.9 5820.4 5822.7 5827.4 5891.9 5891.9 1458.2 1466.8 1470.3 1474.0 1479.1 978.6 1006.2 1024.6 1025.6 1027.9 5398.2 5421.7 5461.8 5466.7 5481.8 5784.5 5792.9 5793.5 5832.3 5833.4 5329.0 5369.7 5609.9 5684.5 5705.2 3107.5 3119.2 3160.9 3201.0 3208.2 5802.3 6099.4 6106.3 6133.5 6262.6 6176.8 6177.4 6194.8 6207.3 6208.8 6146.8 6227.0 6281.4 6296.5 6300.5 5892.2 6023.8 6030.8 6124.8 6128.5 6064.8 6087.4 6101.6 6110.5 6113.7 6090.5 6270.9 6317.4 6317.5 6345.3 4260.2 4295.7 4298.1 4301.4 4309.5 5743.3 5873.2 6072.9 6096.7 6142.4 5835.6 5840.6 5887.9 5908.6 5910.3 5691.7 5856.3 5871.4 5888.0 5890.9 5695.9 5696.1 5696.3 5697.2 5727.5 5905.5 5915.4 5942.7 5972.0 5973.9 5620.2 5751.8 5789.2 5791.7 5801.7 08:28:24 INFO - PROCESS | 32547 | 08:28:24 INFO - PROCESS | 32547 | [#5] yui.html Cycles:180 Average:15200.60 Median:4906.12 stddev:18406.82 (375.2%) stddev-sans-first:18426.62 08:28:24 INFO - PROCESS | 32547 | Values: 784.2 846.9 865.0 866.1 878.2 14224.6 14513.9 14582.3 14608.6 14730.6 11848.4 13806.4 13857.2 13862.8 13876.8 825.6 846.0 846.8 847.9 847.9 844.1 848.0 848.3 848.7 852.6 874.5 875.9 876.5 878.3 879.0 868.4 871.0 875.5 877.6 878.9 633.1 637.4 638.8 639.2 640.5 14590.9 14595.0 14595.3 14628.6 14678.1 13056.5 13080.7 13143.9 13259.3 13603.5 11890.5 11906.8 11926.7 12016.8 12137.0 3890.9 3900.7 3944.2 3944.2 3978.7 58057.1 58504.4 58546.0 58591.8 58790.4 10286.1 10304.2 10915.7 10930.1 11104.2 18769.8 18775.4 18895.0 18941.8 18987.9 7941.0 8044.8 8050.2 8162.1 8188.9 4841.4 4882.4 4929.9 4937.1 4945.3 3398.6 3520.0 3526.5 3531.6 3533.9 613.2 621.5 624.2 626.4 648.7 617.4 645.5 698.5 737.8 738.5 8615.8 8677.3 8794.0 8819.8 8896.5 646.1 655.7 708.3 717.2 732.9 4168.6 4384.0 4402.0 4450.1 4455.9 60687.7 66593.0 67275.3 67292.0 67302.7 57441.4 58392.0 58911.0 59271.7 60554.1 54847.2 55333.0 55335.7 55693.7 56213.4 8140.4 8191.3 8365.8 8572.2 8702.5 34792.5 34799.0 35430.0 35437.6 35987.8 47812.5 47831.0 47997.3 48066.5 48494.0 11127.6 11157.8 11268.3 11284.3 11291.4 12015.8 12312.4 12323.0 12343.8 12419.4 11707.8 11856.1 12378.3 12631.3 12647.2 11622.4 11675.0 11762.6 11882.2 12034.1 11523.6 11528.8 11626.5 11779.8 11828.5 9384.5 9451.2 9464.2 9588.3 9598.1 9960.3 10143.5 10266.3 10282.5 10326.9 08:28:24 INFO - PROCESS | 32547 | -------- Summary: end -------- 08:28:24 INFO - PROCESS | 32547 | 08:28:25 INFO - TEST-INFO | 32547: exit 0 08:28:25 INFO - TEST-OK | dromaeo_css | took 1109892ms 08:28:25 INFO - TEST-START | kraken 08:28:25 INFO - operating with platform_type : linux_ 08:28:25 INFO - Initialising browser for kraken test... 08:28:25 INFO - TEST-INFO | started process 319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprUCIow/profile http://localhost:32958/getInfo.html) 08:28:29 INFO - PROCESS | 319 | 08:28:29 INFO - PROCESS | 319 | (process:390): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:28:30 INFO - PROCESS | 319 | __metrics Screen width/height:1600/1200 08:28:30 INFO - PROCESS | 319 | colorDepth:24 08:28:30 INFO - PROCESS | 319 | Browser inner width/height: 1024/697 08:28:30 INFO - PROCESS | 319 | __metrics 08:28:30 ERROR - PROCESS | 319 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:28:31 INFO - TEST-INFO | 319: exit 0 08:28:31 INFO - Browser initialized. 08:28:31 INFO - Running cycle 1/1 for kraken test... 08:28:31 INFO - TEST-INFO | started process 443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprUCIow/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:33 INFO - PROCESS | 443 | 08:28:33 INFO - PROCESS | 443 | (process:504): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:28:43 INFO - PROCESS | 443 | RSS: Main: 163586048 08:28:43 INFO - PROCESS | 443 | 08:28:45 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32958/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:46 INFO - PROCESS | 443 | RSS: Main: 167997440 08:28:46 INFO - PROCESS | 443 | 08:28:49 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32958/tests/kraken/driver.html?testName=audio-dft) 08:28:50 INFO - PROCESS | 443 | RSS: Main: 168394752 08:28:50 INFO - PROCESS | 443 | 08:28:52 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32958/tests/kraken/driver.html?testName=audio-fft) 08:28:53 INFO - PROCESS | 443 | RSS: Main: 163041280 08:28:53 INFO - PROCESS | 443 | 08:28:55 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32958/tests/kraken/driver.html?testName=audio-oscillator) 08:28:56 INFO - PROCESS | 443 | RSS: Main: 163303424 08:28:56 INFO - PROCESS | 443 | 08:28:58 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:59 INFO - PROCESS | 443 | RSS: Main: 163766272 08:28:59 INFO - PROCESS | 443 | 08:29:02 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32958/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:02 INFO - PROCESS | 443 | RSS: Main: 164040704 08:29:02 INFO - PROCESS | 443 | 08:29:06 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32958/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:06 INFO - PROCESS | 443 | RSS: Main: 163934208 08:29:06 INFO - PROCESS | 443 | 08:29:09 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32958/tests/kraken/driver.html?testName=json-parse-financial) 08:29:10 INFO - PROCESS | 443 | RSS: Main: 164474880 08:29:10 INFO - PROCESS | 443 | 08:29:11 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:12 INFO - PROCESS | 443 | RSS: Main: 164081664 08:29:12 INFO - PROCESS | 443 | 08:29:14 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:14 INFO - PROCESS | 443 | RSS: Main: 164282368 08:29:14 INFO - PROCESS | 443 | 08:29:16 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:17 INFO - PROCESS | 443 | RSS: Main: 164675584 08:29:17 INFO - PROCESS | 443 | 08:29:20 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:20 INFO - PROCESS | 443 | RSS: Main: 164835328 08:29:20 INFO - PROCESS | 443 | 08:29:23 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:24 INFO - PROCESS | 443 | RSS: Main: 164782080 08:29:24 INFO - PROCESS | 443 | 08:29:25 INFO - PROCESS | 443 | Cycle 1(1): loaded http://localhost:32958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32958/tests/kraken/driver.html?testName=ai-astar) 08:29:26 INFO - PROCESS | 443 | RSS: Main: 166051840 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | __start_tp_report 08:29:26 INFO - PROCESS | 443 | _x_x_mozilla_page_load 08:29:26 INFO - PROCESS | 443 | _x_x_mozilla_page_load_details 08:29:26 INFO - PROCESS | 443 | |i|pagename|runs| 08:29:26 INFO - PROCESS | 443 | |0;ai-astar;108;110;105;111;111;113;105;114;113;111 08:29:26 INFO - PROCESS | 443 | |1;audio-beat-detection;157;125;161;192;134;161;160;127;200;131 08:29:26 INFO - PROCESS | 443 | |2;audio-dft;163;168;162;163;162;164;169;162;162;163 08:29:26 INFO - PROCESS | 443 | |3;audio-fft;77;76;76;149;77;75;77;77;164;77 08:29:26 INFO - PROCESS | 443 | |4;audio-oscillator;92;93;152;92;92;92;149;92;93;153 08:29:26 INFO - PROCESS | 443 | |5;imaging-gaussian-blur;119;118;117;117;118;119;117;118;117;117 08:29:26 INFO - PROCESS | 443 | |6;imaging-darkroom;147;148;148;146;146;147;148;146;147;147 08:29:26 INFO - PROCESS | 443 | |7;imaging-desaturate;96;97;97;96;96;96;95;98;96;95 08:29:26 INFO - PROCESS | 443 | |8;json-parse-financial;60;57;57;58;56;63;59;79;55;57 08:29:26 INFO - PROCESS | 443 | |9;json-stringify-tinderbox;61;60;60;60;59;58;59;59;61;59 08:29:26 INFO - PROCESS | 443 | |10;stanford-crypto-aes;81;83;84;79;80;79;80;80;80;80 08:29:26 INFO - PROCESS | 443 | |11;stanford-crypto-ccm;125;135;134;126;132;131;129;134;154;126 08:29:26 INFO - PROCESS | 443 | |12;stanford-crypto-pbkdf2;169;174;169;171;170;170;173;174;169;177 08:29:26 INFO - PROCESS | 443 | |13;stanford-crypto-sha256-iterative;67;66;66;66;69;63;64;64;65;65 08:29:26 INFO - PROCESS | 443 | __end_tp_report 08:29:26 INFO - PROCESS | 443 | __start_cc_report 08:29:26 INFO - PROCESS | 443 | _x_x_mozilla_cycle_collect,842 08:29:26 INFO - PROCESS | 443 | __end_cc_report 08:29:26 INFO - PROCESS | 443 | __startTimestamp1462548566151__endTimestamp 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | ------- Summary: start ------- 08:29:26 INFO - PROCESS | 443 | Number of tests: 14 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.18 (2.9%) stddev-sans-first:3.28 08:29:26 INFO - PROCESS | 443 | Values: 108.0 110.0 105.0 111.0 111.0 113.0 105.0 114.0 113.0 111.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:160.50 stddev:26.24 (16.3%) stddev-sans-first:27.82 08:29:26 INFO - PROCESS | 443 | Values: 157.0 125.0 161.0 192.0 134.0 161.0 160.0 127.0 200.0 131.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.57 (1.6%) stddev-sans-first:2.71 08:29:26 INFO - PROCESS | 443 | Values: 163.0 168.0 162.0 163.0 162.0 164.0 169.0 162.0 162.0 163.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#3] audio-fft Cycles:10 Average:92.50 Median:77.00 stddev:33.92 (44.1%) stddev-sans-first:35.51 08:29:26 INFO - PROCESS | 443 | Values: 77.0 76.0 76.0 149.0 77.0 75.0 77.0 77.0 164.0 77.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.54 (31.0%) stddev-sans-first:29.52 08:29:26 INFO - PROCESS | 443 | Values: 92.0 93.0 152.0 92.0 92.0 92.0 149.0 92.0 93.0 153.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 08:29:26 INFO - PROCESS | 443 | Values: 119.0 118.0 117.0 117.0 118.0 119.0 117.0 118.0 117.0 117.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:29:26 INFO - PROCESS | 443 | Values: 147.0 148.0 148.0 146.0 146.0 147.0 148.0 146.0 147.0 147.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 08:29:26 INFO - PROCESS | 443 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 95.0 98.0 96.0 95.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:58.50 stddev:7.02 (12.0%) stddev-sans-first:7.44 08:29:26 INFO - PROCESS | 443 | Values: 60.0 57.0 57.0 58.0 56.0 63.0 59.0 79.0 55.0 57.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:0.88 08:29:26 INFO - PROCESS | 443 | Values: 61.0 60.0 60.0 60.0 59.0 58.0 59.0 59.0 61.0 59.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:1.65 (2.1%) stddev-sans-first:1.74 08:29:26 INFO - PROCESS | 443 | Values: 81.0 83.0 84.0 79.0 80.0 79.0 80.0 80.0 80.0 80.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:133.00 stddev:8.36 (6.3%) stddev-sans-first:8.40 08:29:26 INFO - PROCESS | 443 | Values: 125.0 135.0 134.0 126.0 132.0 131.0 129.0 134.0 154.0 126.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.00 stddev:2.76 (1.6%) stddev-sans-first:2.76 08:29:26 INFO - PROCESS | 443 | Values: 169.0 174.0 169.0 171.0 170.0 170.0 173.0 174.0 169.0 177.0 08:29:26 INFO - PROCESS | 443 | 08:29:26 INFO - PROCESS | 443 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.72 (2.6%) stddev-sans-first:1.73 08:29:26 INFO - PROCESS | 443 | Values: 67.0 66.0 66.0 66.0 69.0 63.0 64.0 64.0 65.0 65.0 08:29:26 INFO - PROCESS | 443 | -------- Summary: end -------- 08:29:26 INFO - PROCESS | 443 | 08:29:27 INFO - TEST-INFO | 443: exit 0 08:29:27 INFO - TEST-OK | kraken | took 61742ms 08:29:27 INFO - SUITE-END | took 1171s 08:29:27 INFO - Completed test suite (00:19:31) 08:29:27 INFO - javascript benchmark 08:29:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.1246407238004, 3185.554022436858, 3191.92020199495, 3219.2112932331584, 3246.853891574879, 5487.451254874515, 5517.144842549406, 5520.47555482229, 5592.245046918665, 5634.605577609559, 5447.101228297336, 5560.582956278275, 5586.972065139679, 5598.580106492009, 5610.579206559504, 4989.975050124763, 5003.524665156822, 5139.897202055957, 5165.431802501741, 5200.843974680765, 853.0865669898091, 4930.359053323063, 5030.144875371196, 5082.593392528589, 5147.845564633067, 5017.422996355429, 5020.7489625518765, 5059.6964182149, 5061.038402703474, 5068.34111565496, 5065.569426598743, 5075.568576670988, 5075.5939524838295, 5075.822346217901, 5097.13348730713, 4980.153373926441, 4985.52637499437, 5009.899802003976, 5026.170681837492, 5050.696958182521, 5412.0, 5479.369872464637, 5483.945160548423, 5487.451254874521, 5551.8889622207325, 5724.026915424388, 5899.616524925866, 5903.0555111182, 5923.496502797268, 5942.435468630473, 5950.375210602911, 6022.3676513966275, 6037.969810150965, 6072.908906366408, 6100.115483254947, 5602.971985140089, 5607.467290607427, 5623.606347555673, 5627.662340259598, 5632.014397480424, 5945.791897283574, 6014.127951447103, 6057.878842423127, 6153.2000839890525, 6165.691715414211, 5732.971335143297, 5736.885262294814, 5741.45456181662, 5747.511461525817, 5760.0, 5895.616784908967, 5903.0, 5909.5863289569315, 5921.111833225051, 5928.140419639129, 5872.941270587239, 5921.851953701192, 5937.465628093492, 5984.551158663117, 5991.191189189491, 5963.522918166536, 5972.641641501524, 6005.759769609254, 6013.368596297413, 6014.729337179838, 4419.469663640384, 4503.864884053483, 4515.2324104902245, 4523.2988886722615, 4531.501534831166, 3882.281777871103, 3963.4451176835264, 3976.1053762903693, 4011.0, 4024.4566983456857, 5626.97186514073, 5642.7178641067785, 5697.173909783141, 5713.657180569179, 5715.657060576379, 5882.058870580687, 5995.160677505153, 6004.669743164168, 6007.249093863267, 6014.578979471483, 5693.516051135617, 5715.657060576379, 5739.713014349266, 5755.280589926259, 5785.8553536161935, 5133.768980395891, 5157.8452646420665, 5159.071367153873, 5172.456892026358, 5175.094358487249, 5995.490383317467, 6107.037103281039, 6249.468795152463, 6260.154879091265, 6263.843403914939, 6005.939940600538, 6067.059605761114, 6072.666003369857, 6074.605150665193, 6115.7247923844425, 6148.262208535004, 6149.723262453111, 6172.783952561639, 6181.134641150153, 6225.844353891189, 5602.607817452739, 5639.774409023593, 5652.095664693629, 5922.052471604523, 5927.4665280125, 5740.741666624928, 5782.884342313214, 5787.189793429007, 5791.565632577489, 5847.94152058474, 5558.694271815089, 5562.833115006556, 5564.944350556442, 5569.526590239713, 5624.240727501735, 5548.056830338772, 5574.0, 5705.087186050212, 5779.624324418899, 5807.303123625192, 5647.407022262768, 5679.943200567942, 5680.11958146488, 5711.543076553949, 5714.20001199824, 5825.79609713658, 5862.560307977004, 5863.589548731547, 5889.646621202742, 5907.084401917709, 5570.888582228414, 5712.857178570569, 5714.342850572071, 5746.511546518593, 5758.884822303614], "value": 5434.821313595236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.7121381736766, 656.3961155736722, 659.3571268013684, 670.2158474584735, 694.2987582541631, 38943.415848762255, 39725.0, 42681.359779603255, 42688.14623707524, 42765.57234427659, 44956.0, 45027.324590131175, 45385.0, 45391.0, 45396.3190552142, 8951.597178127, 9118.17936385725, 9123.635054597808, 9128.315376346767, 9131.954340228323, 8927.285817134614, 9052.049534798816, 9068.455892646429, 9074.77313067172, 9075.41009834362, 9130.863037054449, 9142.634294628207, 9152.4966126863, 9163.08369163085, 9184.173424391804, 9013.32400069994, 9065.41074830134, 9094.954525227398, 9103.0, 9112.0, 8973.910260897437, 9049.864252036225, 9061.954690226572, 9068.229200517964, 9074.500902450363, 34865.30269394598, 42131.368029479585, 42220.78889605563, 42371.57628423707, 42515.787421063, 3430.382531144393, 3562.251927095313, 3584.426491761306, 3680.0799800049986, 3694.5012423323046, 30713.69286307131, 31315.217119571964, 31321.686783132332, 31431.842840785648, 32506.0, 4095.201435720036, 4284.207421627009, 4320.416743739618, 4324.178406102862, 4381.145676593065, 320421.0, 320572.0, 321423.0, 322533.0, 324794.0, 35511.64488355135, 63332.683336583024, 64131.0, 64261.67869160718, 64524.0, 36065.278694425964, 37910.81044594815, 37948.62051379506, 38064.42903356452, 38119.428208576894, 16118.516444506684, 16169.0, 16262.837371626132, 16312.836871631369, 16322.102284374474, 13664.590062298146, 13721.313934303245, 13734.381952812148, 13748.93125534366, 13835.30823458823, 8750.47497150173, 8766.91233087661, 8791.780205494913, 8816.250618697482, 8832.602532886036, 3324.634290228073, 3340.3820293245826, 3366.562346894888, 3379.4930760385646, 3405.404054290489, 1080.6271836216492, 1121.388843080523, 1128.8588926384202, 1158.6060739348493, 1187.9486654310824, 32702.509462358084, 33021.0, 33192.66807331896, 34055.82972085124, 34087.488687669706, 1148.1331594646156, 1159.8956093951585, 1176.6764139861607, 1182.586094866807, 1244.8817362350744, 16746.581335466468, 16845.410410635814, 16954.576135596708, 17068.573285667957, 17122.657546848994, 498042.0, 500173.0, 502244.0, 504012.0, 505376.0, 57854.0, 59113.70443147757, 59168.704156479806, 59257.70371148117, 59379.40620593739, 1423.2812429722717, 1434.483585909072, 1437.6334034821264, 1444.3861358922627, 1444.9422023118957, 30179.762510095097, 31179.53230701496, 31207.0, 31497.527537086502, 32133.35733285368, 52199.73900130475, 52797.0, 53594.19608705794, 53626.73186634042, 53832.73083634557, 352479.0, 352836.0, 354561.0, 356053.0, 357131.0, 28918.855405722836, 29181.270468238465, 29248.707512925448, 29324.0, 29596.704032959395, 48955.26567101567, 49930.75034624804, 50377.74811125921, 50507.494925050276, 50537.0, 41205.793971029954, 42142.57857421387, 42525.5747442534, 42687.57312426836, 42770.144597108505, 40853.79573102116, 41560.58439415688, 41611.37582936319, 42083.53026044153, 43082.56917430911, 43497.56502434935, 44150.33774493321, 45884.31173532466, 47023.52976470192, 47419.76290118528, 38741.2251754969, 42513.90169199223, 42859.57140428556, 42924.14151717011, 42943.7852810734, 33861.830690846386, 33936.66063339335, 33994.0, 34047.0, 34638.653613463546], "value": 19391.022626152844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7602974170884, 395.12676983865657, 398.219489799992, 400.59139677528924, 412.8575641403715, 13729.313534323293, 17808.0, 18482.44552663419, 19619.5095122622, 19679.311224107158, 18620.72068918964, 18653.25386984519, 19145.904270478663, 19412.805871941277, 19420.611587768235, 5635.520980716634, 5670.8015219467325, 5711.543556393135, 5731.455511726379, 5825.679587622679, 5667.433256674341, 5696.316442026962, 5699.116636921284, 5745.511631511326, 5754.884902301951, 5388.164834450647, 5677.148427735831, 5678.346990096151, 5691.08942569189, 5704.34400043994, 5622.240997465351, 5651.0, 5696.145578163288, 5848.41515848416, 6320.968395157995, 5715.342735585419, 5753.827385178452, 5790.855228619276, 5793.507551858097, 5821.18503409523, 20144.79855201444, 21305.786942130537, 22338.441538961495, 22357.55284894293, 22436.775632243633, 2246.831487638434, 2247.685324054634, 2344.542814151241, 2364.0898254172093, 2940.5736168255485, 10197.439140847251, 10205.87735349111, 10303.948480257552, 10306.175505959505, 10631.84052239217, 1871.2982631513182, 1878.0985127138913, 1892.0823400650672, 1907.294301108585, 1922.1158267197106, 72898.0, 75317.24682753158, 76580.23419765843, 77710.0, 81917.59041204816, 10388.48057597117, 10695.465226738632, 10764.515596798163, 10918.890811091787, 11008.834867476995, 15399.538013859603, 15420.84579154194, 15445.613859653598, 15518.84481155174, 15539.611509712347, 8061.919380806117, 8282.8343433131, 8328.750137495885, 8375.288100511403, 8416.074231834617, 8050.11448740638, 8108.797280068045, 8114.0, 8176.3458923286, 8267.29727973129, 4621.168189725881, 4691.882702932386, 4737.881552961135, 4762.904741905142, 4805.486271824364, 1922.2036477955926, 1930.362980216525, 1992.4819546917906, 1996.2913165826212, 2049.1803278688644, 992.265723364705, 1043.3844032021143, 1054.541274545575, 1054.715226888751, 1148.9195756297147, 18694.906525467286, 19277.51806204828, 19449.4165175045, 19505.707414388795, 19713.901430492755, 1054.3568423261804, 1072.9034386905216, 1075.1237741240864, 1082.1396989393452, 1086.7772106718103, 10692.411917344622, 11105.278156919774, 11126.332420054823, 11168.162387820947, 11208.607698730668, 533895.0, 534779.0, 536906.0, 538186.0, 542005.0, 84231.5788421054, 96592.51703741578, 97794.0, 98502.5074874621, 102332.0, 495.0988205291697, 496.9353983982059, 518.264065027654, 519.1926554208167, 522.4357693690805, 10614.575416983234, 10702.839457408301, 10810.135189185004, 10927.180461465581, 11056.723581910195, 41108.58891411167, 41394.844748105046, 41473.37789933093, 41662.791686041375, 42533.0, 59505.53708471795, 59548.0, 61125.0, 61151.38848611457, 62388.688056559426, 8517.787055323666, 8683.198541072064, 8756.912430875609, 8773.912260877565, 8801.823963520821, 12807.61577152687, 13256.801147982595, 13416.329183540589, 13554.525591604246, 13879.167249965034, 11663.24188927717, 11984.880151198726, 12005.219660722025, 12049.397530123633, 12049.578264760692, 8571.871421928552, 11644.301341919512, 11724.648260552198, 11760.88239117598, 11843.28940263587, 11956.461959211681, 11956.641300760992, 12016.939915300367, 12027.15809893299, 12056.578019769266, 8873.689420870238, 8980.550972451481, 9016.549172541478, 9046.728598142066, 9063.637454501746, 8466.534340611079, 10882.891171088188, 11732.178747487595, 11776.352300623548, 11851.585194518151], "value": 8999.910152401642, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.303880215101, 1561.69546938347, 1700.70237708401, 1816.6729988602056, 1822.7812662480505, 7683.846323073535, 8318.667253309868, 8392.958035209815, 8895.0, 8905.732828015161, 8464.576771161433, 8736.432131911437, 8792.604332805024, 8813.823723525526, 8826.073262307462, 2230.431240033789, 2259.8757068361233, 2262.366537369539, 2265.2977576951116, 2275.2719129878446, 2211.889405529717, 2221.9777802222015, 2250.3024062540585, 2262.671912572676, 2265.8640481571074, 2243.2597242909883, 2253.43664083979, 2256.199049337486, 2264.501809601885, 2272.943176420594, 2205.757366689663, 2209.7458792238936, 2209.845310828243, 2217.689523466716, 2218.8335874809372, 2169.4684802223396, 2213.103693004336, 2215.3464727905143, 2224.63293556563, 2302.919397821085, 8672.696455624024, 8684.2618377438, 8690.956545217297, 8733.563321833883, 8742.213200811957, 5177.508136727042, 5301.416844147141, 5342.706151161685, 5351.678899266057, 5353.277307563507, 3361.5461912641726, 3478.0783092480515, 3541.9645803541894, 3595.46068089786, 3615.7468977171607, 1172.6657902497832, 1180.8405865208174, 1209.0750575809514, 1219.9451024703822, 1244.975100497985, 11751.588694395656, 11787.469563869561, 11824.11319151067, 11838.230515016583, 11874.465649045727, 4709.95290047102, 4815.133276010351, 4902.7058376497525, 4918.188498897642, 4958.776855041532, 10067.244956628283, 10096.091351778228, 10127.088562029452, 10145.08694217524, 10180.134688551409, 5504.779808807683, 5539.41836107211, 5547.694876781816, 5563.0, 5563.304586926634, 4359.847405340861, 4849.563539281411, 4964.702117872939, 4989.351384320015, 5099.59203263738, 4001.9599804001587, 4023.2959232134845, 4106.815193316308, 4111.732737372061, 4264.616184543406, 1270.4727538071782, 1296.4749276542827, 1301.2322729589587, 1311.4229738914846, 1321.062045947369, 985.2315194148575, 988.1699372527112, 993.8558908958305, 1003.6085926488676, 1013.7871047080196, 5960.344362120163, 5992.730327135289, 6025.969870150709, 6054.091886217015, 6085.661154546081, 452.9524399937959, 455.02851412235117, 461.68374663355706, 462.0182113009854, 464.1181754666094, 4043.3126368517424, 4176.916461670749, 4220.873373798791, 4227.809748561261, 4246.766427846436, 10586.629467968738, 10878.619248326271, 10978.066864316623, 11006.779864402668, 11022.50398732043, 10136.797264054825, 10649.0, 10731.356118632906, 10920.235583509078, 10974.012338889539, 8238.794030149174, 8456.661733530713, 8495.1080136586, 8501.787455313666, 8512.40413171072, 5927.110933360031, 6074.635521868702, 6155.630662160284, 6219.626822390671, 6224.813255602339, 10258.384496930208, 10478.790424191626, 10499.632512862014, 10615.256932014685, 10691.358518488916, 10014.19886409071, 10516.0, 10536.473176341306, 10539.63111291101, 10640.521176547229, 7084.822879428056, 7432.885067239958, 7619.238076192337, 7698.230176982257, 7897.328727058264, 8556.871646925176, 8631.654733810577, 8654.134586541548, 8661.177188167114, 8665.566721664018, 7496.0, 7681.9231807683445, 7739.883901741591, 7884.921150788648, 7925.28672419462, 7473.327400533978, 7745.65144568507, 7754.922450775645, 7815.335696465864, 7818.530888146502, 6850.45196384298, 6900.6204658744255, 6931.722731090902, 6938.132733408324, 6944.722211111499, 4864.391951006124, 4926.802927882844, 5033.697978121324, 5130.281760553451, 5150.690958542499, 4832.879178020437, 4982.128127577587, 5114.258432527188, 5132.7433628317685, 5147.639665223398], "value": 4574.988965310862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.75175246194044, 339.30442592684994, 342.88856121760426, 349.6136768870397, 350.85614897891867, 5591.189277554758, 5664.688442135691, 5688.829335119948, 5695.889301586192, 5721.456461636149, 5615.382307946123, 5616.831495055145, 5617.4382561743805, 5630.5495560355175, 5653.830385088444, 4149.1701659668115, 4278.8502402415925, 4356.934645980313, 4357.869263922087, 4358.368036634702, 4340.544242854502, 4356.803943822536, 4361.538884473689, 4378.2775841986195, 4392.450943632046, 4286.207051695431, 4313.805878735465, 4321.416608757809, 4334.783260836962, 4335.393044973691, 4182.7281226720315, 4268.018355778173, 4269.765162916038, 4283.164782867342, 4292.248856450109, 3772.792496412696, 3777.2823163599105, 3783.356829339019, 3795.905102372435, 3824.770513769155, 5304.761285742151, 5365.973170134124, 5371.409144994048, 5458.235846981426, 5479.4520547945285, 4931.827386041507, 4992.301077849104, 5006.549410553068, 5019.4227663818765, 5032.874178145539, 5774.913376299359, 5826.417358264182, 5827.300723913115, 5839.211706419622, 5847.152162936351, 4179.310413781723, 4205.789710514493, 4211.284081706087, 4214.220369231672, 4221.176870510251, 5802.448767367094, 6001.0, 6024.156618073517, 6024.258962172201, 6060.484858787008, 4258.978705106455, 4268.765217913045, 4272.359146128106, 4309.310510318334, 4312.805923733439, 4319.136172765397, 4353.238183317907, 4358.363190269904, 4388.210122178039, 4415.315626077963, 4826.831060912851, 4939.506049395103, 4946.826861059845, 4960.379952505937, 4984.8753781155765, 5820.3888591698105, 5822.748109156551, 5827.4172582741385, 5891.911621325684, 5891.941080589139, 1458.2125652147934, 1466.8459811719829, 1470.3089547912464, 1473.9705205896037, 1479.1199236454293, 978.5645387802359, 1006.1699098243978, 1024.59528486249, 1025.646152077532, 1027.8796112237546, 5398.217258497496, 5421.701806400607, 5461.754221060062, 5466.671999680032, 5481.835544933659, 5784.4504772046585, 5792.9420705793245, 5793.478586927196, 5832.287986086405, 5833.358330583633, 5329.0, 5369.6509726867625, 5609.943900560942, 5684.545236381162, 5705.1727499512335, 3107.4717298059386, 3119.173419043955, 3160.920976975594, 3201.0, 3208.2300247940793, 5802.303723553201, 6099.420555047263, 6106.267247930276, 6133.478654314434, 6262.5929314594405, 6176.845578860564, 6177.413145751147, 6194.783182588588, 6207.255129384503, 6208.81373558794, 6146.754129834757, 6227.0, 6281.434670879643, 6296.527760417987, 6300.527460440485, 5892.175095486549, 6023.819285421444, 6030.7636934427455, 6124.785632502841, 6128.479079278133, 6064.787732429344, 6087.421694938974, 6101.572889897665, 6110.541709371726, 6113.694315284307, 6090.482309003607, 6270.905936410866, 6317.368263173829, 6317.4630156437215, 6345.303246120473, 4260.233158031584, 4295.742255464682, 4298.140371925565, 4301.419308393452, 4309.547497512716, 5743.253377060955, 5873.207117039145, 6072.939270607414, 6096.725647345791, 6142.416470435302, 5835.649861008353, 5840.591158618856, 5887.911681324869, 5908.586398952032, 5910.320313164041, 5691.658500489983, 5856.267966504187, 5871.412858714265, 5888.0, 5890.879283457866, 5695.8860822784145, 5696.1455781633085, 5696.259486266758, 5697.20538030519, 5727.5417966561745, 5905.527557795452, 5915.40845915405, 5942.6731529766275, 5971.970140149271, 5973.880522389615, 5620.18507316445, 5751.769929202785, 5789.218455508452, 5791.681457519877, 5801.6519008859605], "value": 4459.344814411257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.2040329065999, 846.9449485783424, 864.9740507784765, 866.1381924984637, 878.1657425445828, 14224.644383890409, 14513.854861451382, 14582.343794529244, 14608.561743147697, 14730.63173420665, 11848.407579621027, 13806.378712957916, 13857.168569885815, 13862.792058119136, 13876.791848122286, 825.5707032343163, 845.9873101903477, 846.7544412120478, 847.8812966184739, 847.9236868681818, 844.1094645149365, 848.0417128644623, 848.2789628815519, 848.6732607945954, 852.595017366749, 874.4840544078992, 875.8554838451648, 876.5003947749785, 878.301750108662, 879.0242830458186, 868.4181598329135, 871.0418539606445, 875.5315905990265, 877.5787621941504, 878.9121087891224, 633.100996584846, 637.3721883944311, 638.8243233110885, 639.1722719078804, 640.5228105061713, 14590.854091459056, 14595.0, 14595.343209555489, 14628.561143165722, 14678.119312841158, 13056.477740890354, 13080.738385232336, 13143.934280328633, 13259.3370331484, 13603.455861765517, 11890.464929078213, 11906.761864762742, 11926.701832454171, 12016.819747703792, 12137.0, 3890.922181556353, 3900.7464514806447, 3944.1520073184115, 3944.2111577684577, 3978.7214894957365, 58057.129143062884, 58504.41495585032, 58546.0, 58591.82816343692, 58790.41209587892, 10286.125679317192, 10304.175665946706, 10915.672529824118, 10930.089496557055, 11104.222704410613, 18769.81230187708, 18775.436736897915, 18895.0, 18941.81058189428, 18987.905060474608, 7940.960295198487, 8044.839103217902, 8050.154733752989, 8162.14297498766, 8188.877166842502, 4841.394825646794, 4882.389701287339, 4929.852104436873, 4937.061958227925, 4945.2582112683385, 3398.5921689397433, 3520.0495866116007, 3526.541549598587, 3531.5938667053106, 3533.858645654145, 613.2181468627535, 621.5276389943585, 624.1760875644197, 626.3986572889986, 648.6529706606942, 617.4412156997925, 645.4965127200791, 698.4552049401475, 737.8118579762127, 738.512581696078, 8615.827683446421, 8677.305815534743, 8793.988691300454, 8819.779505512286, 8896.466212027299, 646.0503060501056, 655.7049327802508, 708.3447810775116, 717.160921721587, 732.9157146928064, 4168.562300958356, 4383.956160438419, 4402.031553058322, 4450.109978004347, 4455.933161002587, 60687.69656151691, 66593.00110498346, 67275.32724672789, 67292.0, 67302.66348668226, 57441.425585744444, 58392.0, 58911.0, 59271.703641481516, 60554.09168862383, 54847.177292340646, 55332.99999999919, 55335.723321383135, 55693.72153139208, 56213.43786562082, 8140.389470789596, 8191.262786349257, 8365.790855228424, 8572.185642363966, 8702.47785132894, 34792.47811282782, 34799.0, 35430.0, 35437.64562354344, 35987.820060899525, 47812.5218747822, 47831.0, 47997.28004080011, 48066.5193348062, 48494.0, 11127.610533631285, 11157.776844463227, 11268.267562608404, 11284.32294062359, 11291.43542822872, 12015.819762703391, 12312.384380780746, 12323.0, 12343.753124937271, 12419.441125149571, 11707.824382634097, 11856.110791690486, 12378.319192444502, 12631.305278209788, 12647.241165530098, 11622.418879056182, 11675.03327534007, 11762.647120586054, 11882.16824822254, 12034.097442691658, 11523.596674116701, 11528.769424611628, 11626.53493860236, 11779.764404712028, 11828.46771895284, 9384.483853388128, 9451.196648284698, 9464.194557195931, 9588.280878933969, 9598.088181622734, 9960.302778805413, 10143.49282535885, 10266.332688375232, 10282.485875706334, 10326.948365258126], "value": 6742.296166444331, "unit": "score"}], "name": "dromaeo_css", "value": 7121.788641115231, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 105.0, 111.0, 111.0, 113.0, 105.0, 114.0, 113.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 161.0, 192.0, 134.0, 161.0, 160.0, 127.0, 200.0, 131.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 162.0, 163.0, 162.0, 164.0, 169.0, 162.0, 162.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 149.0, 77.0, 75.0, 77.0, 77.0, 164.0, 77.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 92.0, 92.0, 92.0, 149.0, 92.0, 93.0, 153.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 95.0, 98.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 58.0, 56.0, 63.0, 59.0, 79.0, 55.0, 57.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 59.0, 58.0, 59.0, 59.0, 61.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 84.0, 79.0, 80.0, 79.0, 80.0, 80.0, 80.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 135.0, 134.0, 126.0, 132.0, 131.0, 129.0, 134.0, 154.0, 126.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 169.0, 171.0, 170.0, 170.0, 173.0, 174.0, 169.0, 177.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 69.0, 63.0, 64.0, 64.0, 65.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1562.0999999999997, "alertThreshold": 2.0}]} 08:29:27 INFO - Return code: 0 08:29:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:27 ERROR - # TBPL SUCCESS # 08:29:27 INFO - Running post-action listener: _resource_record_post_action 08:29:27 INFO - ##### 08:29:27 INFO - ##### Finished run-tests step (success) 08:29:27 INFO - ##### 08:29:27 INFO - Running post-run listener: _resource_record_post_run 08:29:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 553525248; Read time: 0; Write time: 479440 08:29:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244772864; Read time: 0; Write time: 280236 08:29:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 289689600; Read time: 0; Write time: 190520 08:29:28 INFO - Running post-run listener: _upload_blobber_files 08:29:28 INFO - Blob upload gear active. 08:29:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:28 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 08:29:28 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'] 08:29:28 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 08:29:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:29 INFO - (blobuploader) - INFO - Done attempting. 08:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:30 INFO - (blobuploader) - INFO - Done attempting. 08:29:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:30 INFO - Return code: 0 08:29:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bb075cec82752af1de0f3262d05f12995d5a4fb16016e870c4070884ab62465e4b51a902d356518466ff55c0fc3b6b5d532850991dec03de9d01e28123c6a2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1418108ce2c32d1eac4890c909d1c7e72afe2d2a1528e722ef464b6713da0af830e865fac8035e34880d918f02a10ec3430815e116a63758bc60e41a78ee9661"} 08:29:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:30 INFO - Contents: 08:29:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bb075cec82752af1de0f3262d05f12995d5a4fb16016e870c4070884ab62465e4b51a902d356518466ff55c0fc3b6b5d532850991dec03de9d01e28123c6a2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1418108ce2c32d1eac4890c909d1c7e72afe2d2a1528e722ef464b6713da0af830e865fac8035e34880d918f02a10ec3430815e116a63758bc60e41a78ee9661"} 08:29:30 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:30 INFO - Copying logs to upload dir... 08:29:30 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.446923 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-06 08:29:29.996183) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 08:29:30.000360) ========= 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=4300f881736b422476174874000001bc-1462546688.476896-1627948680 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/1bb075cec82752af1de0f3262d05f12995d5a4fb16016e870c4070884ab62465e4b51a902d356518466ff55c0fc3b6b5d532850991dec03de9d01e28123c6a2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1418108ce2c32d1eac4890c909d1c7e72afe2d2a1528e722ef464b6713da0af830e865fac8035e34880d918f02a10ec3430815e116a63758bc60e41a78ee9661"} build_url:https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/DzUVoZqYTJOKfCm7mggS9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bb075cec82752af1de0f3262d05f12995d5a4fb16016e870c4070884ab62465e4b51a902d356518466ff55c0fc3b6b5d532850991dec03de9d01e28123c6a2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1418108ce2c32d1eac4890c909d1c7e72afe2d2a1528e722ef464b6713da0af830e865fac8035e34880d918f02a10ec3430815e116a63758bc60e41a78ee9661"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 08:29:30.027926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:29:30.028446) ========= 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=4300f881736b422476174874000001bc-1462546688.476896-1627948680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:29:30.111624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 08:29:30.111942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 08:29:30.112235) ========= ========= Total master_lag: 0.19 =========