builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1461593967.25 results: success (0) buildid: 20160425043002 builduid: 5be39bc928ed47d8a82c92eb4174f9f2 revision: 1c6385ae1fe7e37d8f23f958ce14582f07af729e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.250049) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.250552) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.250849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.271313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.271641) ========= 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=82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 07:19:27-- 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% 103M=0s 2016-04-25 07:19:27 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.504432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.504978) ========= 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=82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013185 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.555857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:27.556444) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c6385ae1fe7e37d8f23f958ce14582f07af729e --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 1c6385ae1fe7e37d8f23f958ce14582f07af729e --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=82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 07:19:27,610 truncating revision to first 12 chars 2016-04-25 07:19:27,610 Setting DEBUG logging. 2016-04-25 07:19:27,610 attempt 1/10 2016-04-25 07:19:27,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c6385ae1fe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 07:19:27,995 unpacking tar archive at: mozilla-central-1c6385ae1fe7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700883 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:28.271441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:28.271892) ========= script_repo_revision: 1c6385ae1fe7e37d8f23f958ce14582f07af729e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:28.272301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:28.272565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:28.284365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-25 07:19:28.284982) ========= /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=82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:19:28 INFO - MultiFileLogger online at 20160425 07:19:28 in /builds/slave/test 07:19:28 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 07:19:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:19:28 INFO - {'append_to_log': False, 07:19:28 INFO - 'base_work_dir': '/builds/slave/test', 07:19:28 INFO - 'blob_upload_branch': 'Firefox', 07:19:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:19:28 INFO - 'branch': 'Firefox', 07:19:28 INFO - 'buildbot_json_path': 'buildprops.json', 07:19:28 INFO - 'config_files': ('talos/linux_config.py',), 07:19:28 INFO - 'default_actions': ('clobber', 07:19:28 INFO - 'read-buildbot-config', 07:19:28 INFO - 'download-and-extract', 07:19:28 INFO - 'populate-webroot', 07:19:28 INFO - 'create-virtualenv', 07:19:28 INFO - 'install', 07:19:28 INFO - 'run-tests'), 07:19:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:19:28 INFO - 'download_minidump_stackwalk': True, 07:19:28 INFO - 'download_symbols': 'ondemand', 07:19:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:19:28 INFO - 'tooltool.py': '/tools/tooltool.py', 07:19:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:19:28 INFO - '/tools/misc-python/virtualenv.py')}, 07:19:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:19:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:19:28 INFO - 'installer_path': 'installer.exe', 07:19:28 INFO - 'log_level': 'info', 07:19:28 INFO - 'log_name': 'talos', 07:19:28 INFO - 'log_to_console': True, 07:19:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:19:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:19:28 INFO - 'opt_config_files': (), 07:19:28 INFO - 'pip_index': False, 07:19:28 INFO - 'sps_profile': False, 07:19:28 INFO - 'sps_profile_interval': 0, 07:19:28 INFO - 'suite': 'dromaeojs-e10s', 07:19:28 INFO - 'system_bits': '32', 07:19:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:19:28 INFO - 'title': 'talos-linux64-ix-055', 07:19:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:19:28 INFO - 'use_talos_json': True, 07:19:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:19:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:19:28 INFO - 'work_dir': 'build'} 07:19:28 INFO - ##### 07:19:28 INFO - ##### Running clobber step. 07:19:28 INFO - ##### 07:19:28 INFO - Running pre-action listener: _resource_record_pre_action 07:19:28 INFO - Running main action method: clobber 07:19:28 INFO - rmtree: /builds/slave/test/build 07:19:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:19:28 INFO - Running post-action listener: _resource_record_post_action 07:19:28 INFO - ##### 07:19:28 INFO - ##### Running read-buildbot-config step. 07:19:28 INFO - ##### 07:19:28 INFO - Running pre-action listener: _resource_record_pre_action 07:19:28 INFO - Running main action method: read_buildbot_config 07:19:28 INFO - Using buildbot properties: 07:19:28 INFO - { 07:19:28 INFO - "project": "", 07:19:28 INFO - "product": "firefox", 07:19:28 INFO - "script_repo_revision": "production", 07:19:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:19:28 INFO - "repository": "", 07:19:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:19:28 INFO - "buildid": "20160425043002", 07:19:28 INFO - "pgo_build": "True", 07:19:28 INFO - "basedir": "/builds/slave/test", 07:19:28 INFO - "buildnumber": 717, 07:19:28 INFO - "slavename": "talos-linux64-ix-055", 07:19:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:19:28 INFO - "platform": "ubuntu64_hw", 07:19:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:19:28 INFO - "branch": "mozilla-central", 07:19:28 INFO - "repo_path": "mozilla-central", 07:19:28 INFO - "revision": "1c6385ae1fe7e37d8f23f958ce14582f07af729e", 07:19:28 INFO - "stage_platform": "linux64-pgo", 07:19:28 INFO - "builduid": "5be39bc928ed47d8a82c92eb4174f9f2", 07:19:28 INFO - "slavebuilddir": "test" 07:19:28 INFO - } 07:19:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:19:28 INFO - Running post-action listener: _resource_record_post_action 07:19:28 INFO - ##### 07:19:28 INFO - ##### Running download-and-extract step. 07:19:28 INFO - ##### 07:19:28 INFO - Running pre-action listener: _resource_record_pre_action 07:19:28 INFO - Running main action method: download_and_extract 07:19:28 INFO - mkdir: /builds/slave/test/build/tests 07:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:28 INFO - https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:19:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:19:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:19:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:19:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:19:29 INFO - Downloaded 1361 bytes. 07:19:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:19:29 INFO - Using the following test package requirements: 07:19:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:19:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:19:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:19:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'jsshell-linux-x86_64.zip'], 07:19:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:19:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:19:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:19:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:19:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:19:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:19:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:19:29 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')]} 07:19:29 INFO - https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:19:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:19:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:19:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:30 INFO - Downloaded 23860570 bytes. 07:19:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:19:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:19:32 INFO - Return code: 0 07:19:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:32 INFO - https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:19:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:19:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:19:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:33 INFO - Downloaded 23860570 bytes. 07:19:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:19:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:19:34 INFO - Return code: 0 07:19: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')]} 07:19:34 INFO - https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:19:35 INFO - Downloaded 10840145 bytes. 07:19:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:19:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:19:35 INFO - Return code: 0 07:19:35 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')]} 07:19:35 INFO - https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:19:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:19:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:19:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:19:37 INFO - Downloaded 58337219 bytes. 07:19:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:19:37 INFO - mkdir: /builds/slave/test/properties 07:19:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:19:37 INFO - Writing to file /builds/slave/test/properties/build_url 07:19:37 INFO - Contents: 07:19:37 INFO - build_url:https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:19:37 INFO - Running post-action listener: _resource_record_post_action 07:19:37 INFO - Running post-action listener: set_extra_try_arguments 07:19:37 INFO - ##### 07:19:37 INFO - ##### Running populate-webroot step. 07:19:37 INFO - ##### 07:19:37 INFO - Running pre-action listener: _resource_record_pre_action 07:19:37 INFO - Running main action method: populate_webroot 07:19:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:19:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:19:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:19:37 INFO - '--tppagecycles', 07:19:37 INFO - '7'], 07:19:37 INFO - 'tests': ['tsvgm']}}, 07:19:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:19:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:19:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:19:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:19:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['damp', 'tps']}, 07:19:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'tests': ['damp', 'tps']}, 07:19:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['dromaeo_dom']}, 07:19:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:19:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['a11yr', 07:19:37 INFO - 'ts_paint', 07:19:37 INFO - 'tpaint', 07:19:37 INFO - 'sessionrestore', 07:19:37 INFO - 'sessionrestore_no_auto_restore', 07:19:37 INFO - 'tabpaint']}, 07:19:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:19:37 INFO - 'ts_paint', 07:19:37 INFO - 'tpaint', 07:19:37 INFO - 'sessionrestore', 07:19:37 INFO - 'sessionrestore_no_auto_restore', 07:19:37 INFO - 'tabpaint']}, 07:19:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:19:37 INFO - 'ts_paint', 07:19:37 INFO - 'tpaint', 07:19:37 INFO - 'sessionrestore', 07:19:37 INFO - 'sessionrestore_no_auto_restore', 07:19:37 INFO - 'tabpaint']}, 07:19:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:19:37 INFO - 'ts_paint', 07:19:37 INFO - 'tpaint', 07:19:37 INFO - 'sessionrestore', 07:19:37 INFO - 'sessionrestore_no_auto_restore', 07:19:37 INFO - 'tabpaint']}, 07:19:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['a11yr', 07:19:37 INFO - 'ts_paint', 07:19:37 INFO - 'tpaint', 07:19:37 INFO - 'sessionrestore', 07:19:37 INFO - 'sessionrestore_no_auto_restore', 07:19:37 INFO - 'tabpaint']}, 07:19:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['a11yr', 07:19:37 INFO - 'ts_paint', 07:19:37 INFO - 'tpaint', 07:19:37 INFO - 'sessionrestore', 07:19:37 INFO - 'sessionrestore_no_auto_restore', 07:19:37 INFO - 'tabpaint']}, 07:19:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['tsvgx', 07:19:37 INFO - 'tsvgr_opacity', 07:19:37 INFO - 'tart', 07:19:37 INFO - 'tscrollx', 07:19:37 INFO - 'cart']}, 07:19:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:19:37 INFO - 'tsvgr_opacity', 07:19:37 INFO - 'tart', 07:19:37 INFO - 'tscrollx', 07:19:37 INFO - 'cart']}, 07:19:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'talos_options': ['--disable-e10s'], 07:19:37 INFO - 'tests': ['tp5o']}, 07:19:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'tests': ['tp5o']}, 07:19:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'talos_options': ['--disable-e10s', 07:19:37 INFO - '--xperf_path', 07:19:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:37 INFO - 'tests': ['tp5n']}, 07:19:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:37 INFO - 'talos_options': ['--xperf_path', 07:19:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:37 INFO - 'tests': ['tp5n']}}, 07:19:37 INFO - 'talos.zip': {'path': '', 07:19:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:19:37 INFO - Running post-action listener: _resource_record_post_action 07:19:37 INFO - ##### 07:19:37 INFO - ##### Running create-virtualenv step. 07:19:37 INFO - ##### 07:19:37 INFO - Running pre-action listener: _resource_record_pre_action 07:19:37 INFO - Running main action method: create_virtualenv 07:19:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:19:37 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 07:19:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:19:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:19:38 INFO - Using real prefix '/usr' 07:19:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:19:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:19:40 INFO - Installing pip.................done. 07:19:40 INFO - Return code: 0 07:19:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:19:40 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')]} 07:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:40 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')]} 07:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:40 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 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:19:40 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 07:19:40 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 07:19:40 INFO - Using env: {'DISPLAY': ':0', 07:19:40 INFO - 'HOME': '/home/cltbld', 07:19:40 INFO - 'LANG': 'en_US.UTF-8', 07:19:40 INFO - 'LANGUAGE': 'en_US:en', 07:19:40 INFO - 'LOGNAME': 'cltbld', 07:19:40 INFO - 'MAIL': '/var/mail/cltbld', 07:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:40 INFO - 'MOZ_NO_REMOTE': '1', 07:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:40 INFO - 'NO_EM_RESTART': '1', 07:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:40 INFO - 'PWD': '/builds/slave/test', 07:19:40 INFO - 'SHELL': '/bin/bash', 07:19:40 INFO - 'SHLVL': '1', 07:19:40 INFO - 'TERM': 'linux', 07:19:40 INFO - 'TMOUT': '86400', 07:19:40 INFO - 'USER': 'cltbld', 07:19:40 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:40 INFO - '_': '/tools/buildbot/bin/python'} 07:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:19:41 INFO - Cleaning up... 07:19:41 INFO - Return code: 0 07:19:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:19:41 INFO - Using env: {'DISPLAY': ':0', 07:19:41 INFO - 'HOME': '/home/cltbld', 07:19:41 INFO - 'LANG': 'en_US.UTF-8', 07:19:41 INFO - 'LANGUAGE': 'en_US:en', 07:19:41 INFO - 'LOGNAME': 'cltbld', 07:19:41 INFO - 'MAIL': '/var/mail/cltbld', 07:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:41 INFO - 'MOZ_NO_REMOTE': '1', 07:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:41 INFO - 'NO_EM_RESTART': '1', 07:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:41 INFO - 'PWD': '/builds/slave/test', 07:19:41 INFO - 'SHELL': '/bin/bash', 07:19:41 INFO - 'SHLVL': '1', 07:19:41 INFO - 'TERM': 'linux', 07:19:41 INFO - 'TMOUT': '86400', 07:19:41 INFO - 'USER': 'cltbld', 07:19:41 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:41 INFO - '_': '/tools/buildbot/bin/python'} 07:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:41 INFO - Downloading/unpacking psutil>=0.7.1 07:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:19:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:43 INFO - Installing collected packages: psutil 07:19:43 INFO - Running setup.py install for psutil 07:19:43 INFO - building 'psutil._psutil_linux' extension 07:19:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:19:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:19:46 INFO - building 'psutil._psutil_posix' extension 07:19:46 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 07:19:46 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 07:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:46 INFO - Successfully installed psutil 07:19:46 INFO - Cleaning up... 07:19:46 INFO - Return code: 0 07:19:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:19:46 INFO - Using env: {'DISPLAY': ':0', 07:19:46 INFO - 'HOME': '/home/cltbld', 07:19:46 INFO - 'LANG': 'en_US.UTF-8', 07:19:46 INFO - 'LANGUAGE': 'en_US:en', 07:19:46 INFO - 'LOGNAME': 'cltbld', 07:19:46 INFO - 'MAIL': '/var/mail/cltbld', 07:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:46 INFO - 'MOZ_NO_REMOTE': '1', 07:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:46 INFO - 'NO_EM_RESTART': '1', 07:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:46 INFO - 'PWD': '/builds/slave/test', 07:19:46 INFO - 'SHELL': '/bin/bash', 07:19:46 INFO - 'SHLVL': '1', 07:19:46 INFO - 'TERM': 'linux', 07:19:46 INFO - 'TMOUT': '86400', 07:19:46 INFO - 'USER': 'cltbld', 07:19:46 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:46 INFO - '_': '/tools/buildbot/bin/python'} 07:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:19:47 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 07:19:47 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 07:19:47 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 07:19:47 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 07:19:47 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 07:19:47 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 07:19:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:19:49 INFO - Installing collected packages: mozsystemmonitor 07:19:49 INFO - Running setup.py install for mozsystemmonitor 07:19:49 INFO - Successfully installed mozsystemmonitor 07:19:49 INFO - Cleaning up... 07:19:49 INFO - Return code: 0 07:19:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:19:49 INFO - Using env: {'DISPLAY': ':0', 07:19:49 INFO - 'HOME': '/home/cltbld', 07:19:49 INFO - 'LANG': 'en_US.UTF-8', 07:19:49 INFO - 'LANGUAGE': 'en_US:en', 07:19:49 INFO - 'LOGNAME': 'cltbld', 07:19:49 INFO - 'MAIL': '/var/mail/cltbld', 07:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:49 INFO - 'MOZ_NO_REMOTE': '1', 07:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:49 INFO - 'NO_EM_RESTART': '1', 07:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:49 INFO - 'PWD': '/builds/slave/test', 07:19:49 INFO - 'SHELL': '/bin/bash', 07:19:49 INFO - 'SHLVL': '1', 07:19:49 INFO - 'TERM': 'linux', 07:19:49 INFO - 'TMOUT': '86400', 07:19:49 INFO - 'USER': 'cltbld', 07:19:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:49 INFO - '_': '/tools/buildbot/bin/python'} 07:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:51 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:52 INFO - Downloading docopt-0.6.1.tar.gz 07:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:52 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:52 INFO - Running setup.py install for blobuploader 07:19:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:52 INFO - Running setup.py install for requests 07:19:52 INFO - Running setup.py install for docopt 07:19:52 INFO - Successfully installed blobuploader requests docopt 07:19:52 INFO - Cleaning up... 07:19:52 INFO - Return code: 0 07:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:52 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 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:19:52 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 07:19:52 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 07:19:52 INFO - Using env: {'DISPLAY': ':0', 07:19:52 INFO - 'HOME': '/home/cltbld', 07:19:52 INFO - 'LANG': 'en_US.UTF-8', 07:19:52 INFO - 'LANGUAGE': 'en_US:en', 07:19:52 INFO - 'LOGNAME': 'cltbld', 07:19:52 INFO - 'MAIL': '/var/mail/cltbld', 07:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:52 INFO - 'MOZ_NO_REMOTE': '1', 07:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:52 INFO - 'NO_EM_RESTART': '1', 07:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:52 INFO - 'PWD': '/builds/slave/test', 07:19:52 INFO - 'SHELL': '/bin/bash', 07:19:52 INFO - 'SHLVL': '1', 07:19:52 INFO - 'TERM': 'linux', 07:19:52 INFO - 'TMOUT': '86400', 07:19:52 INFO - 'USER': 'cltbld', 07:19:52 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:52 INFO - '_': '/tools/buildbot/bin/python'} 07:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:53 INFO - Running setup.py (path:/tmp/pip-w6e2Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:53 INFO - Running setup.py (path:/tmp/pip-8KGHPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:53 INFO - Running setup.py (path:/tmp/pip-QcIulU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:53 INFO - Running setup.py (path:/tmp/pip-lnnkdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:53 INFO - Running setup.py (path:/tmp/pip-XMl6gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:53 INFO - Running setup.py (path:/tmp/pip-tFKSYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:53 INFO - Running setup.py (path:/tmp/pip-ZK940v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:53 INFO - Running setup.py (path:/tmp/pip-iq72w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:53 INFO - Running setup.py (path:/tmp/pip-RBHDLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:53 INFO - Running setup.py (path:/tmp/pip-nypIom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:53 INFO - Running setup.py (path:/tmp/pip-U7tXsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:53 INFO - Running setup.py (path:/tmp/pip-937NDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:53 INFO - Running setup.py (path:/tmp/pip-mY4Mvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:53 INFO - Running setup.py (path:/tmp/pip-4BoBhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:54 INFO - Running setup.py (path:/tmp/pip-o8DJRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:54 INFO - Running setup.py (path:/tmp/pip-7gOmx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:54 INFO - Running setup.py (path:/tmp/pip-s3N1ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:54 INFO - Running setup.py install for manifestparser 07:19:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:54 INFO - Running setup.py install for mozcrash 07:19:54 INFO - Running setup.py install for mozdebug 07:19:54 INFO - Running setup.py install for mozdevice 07:19:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:19:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:54 INFO - Running setup.py install for mozfile 07:19:54 INFO - Running setup.py install for mozhttpd 07:19:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:54 INFO - Running setup.py install for mozinfo 07:19:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:54 INFO - Running setup.py install for mozInstall 07:19:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Running setup.py install for mozleak 07:19:55 INFO - Running setup.py install for mozlog 07:19:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Running setup.py install for moznetwork 07:19:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Running setup.py install for mozprocess 07:19:55 INFO - Running setup.py install for mozprofile 07:19:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Running setup.py install for mozrunner 07:19:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:55 INFO - Running setup.py install for mozscreenshot 07:19:55 INFO - Running setup.py install for moztest 07:19:55 INFO - Running setup.py install for mozversion 07:19:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:56 INFO - Cleaning up... 07:19:56 INFO - Return code: 0 07:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:56 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 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:19:56 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 07:19:56 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 07:19:56 INFO - Using env: {'DISPLAY': ':0', 07:19:56 INFO - 'HOME': '/home/cltbld', 07:19:56 INFO - 'LANG': 'en_US.UTF-8', 07:19:56 INFO - 'LANGUAGE': 'en_US:en', 07:19:56 INFO - 'LOGNAME': 'cltbld', 07:19:56 INFO - 'MAIL': '/var/mail/cltbld', 07:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:56 INFO - 'MOZ_NO_REMOTE': '1', 07:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:56 INFO - 'NO_EM_RESTART': '1', 07:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:56 INFO - 'PWD': '/builds/slave/test', 07:19:56 INFO - 'SHELL': '/bin/bash', 07:19:56 INFO - 'SHLVL': '1', 07:19:56 INFO - 'TERM': 'linux', 07:19:56 INFO - 'TMOUT': '86400', 07:19:56 INFO - 'USER': 'cltbld', 07:19:56 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:56 INFO - '_': '/tools/buildbot/bin/python'} 07:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:56 INFO - Running setup.py (path:/tmp/pip-6NMbiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:56 INFO - Running setup.py (path:/tmp/pip-cLwqa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:56 INFO - Running setup.py (path:/tmp/pip-_BJ4DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:56 INFO - Running setup.py (path:/tmp/pip-GIhZvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:56 INFO - Running setup.py (path:/tmp/pip-pe9Z4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:56 INFO - Running setup.py (path:/tmp/pip-xlEvgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:56 INFO - Running setup.py (path:/tmp/pip-X2i2Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:56 INFO - Running setup.py (path:/tmp/pip-86ETcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:56 INFO - Running setup.py (path:/tmp/pip-2ER2cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:56 INFO - Running setup.py (path:/tmp/pip-ZwkMy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:56 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)) 07:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:56 INFO - Running setup.py (path:/tmp/pip-kJDHMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:57 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)) 07:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:57 INFO - Running setup.py (path:/tmp/pip-1g3E2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:57 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)) 07:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:57 INFO - Running setup.py (path:/tmp/pip-FVcsAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:57 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)) 07:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:57 INFO - Running setup.py (path:/tmp/pip-bQXOTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:57 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)) 07:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:57 INFO - Running setup.py (path:/tmp/pip-5ijQG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:57 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)) 07:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:57 INFO - Running setup.py (path:/tmp/pip-bhnCo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:57 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)) 07:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:57 INFO - Running setup.py (path:/tmp/pip-pg6eeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:57 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)) 07:19:57 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)) 07:19:57 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)) 07:19:57 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)) 07:19:57 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)) 07:19:57 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)) 07:19:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:59 INFO - Downloading blessings-1.6.tar.gz 07:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:59 INFO - Installing collected packages: blessings 07:19:59 INFO - Running setup.py install for blessings 07:19:59 INFO - Successfully installed blessings 07:19:59 INFO - Cleaning up... 07:19:59 INFO - Return code: 0 07:19:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:00 INFO - Reading from file tmpfile_stdout 07:20:00 INFO - Current package versions: 07:20:00 INFO - argparse == 1.2.1 07:20:00 INFO - blessings == 1.6 07:20:00 INFO - blobuploader == 1.2.4 07:20:00 INFO - docopt == 0.6.1 07:20:00 INFO - manifestparser == 1.1 07:20:00 INFO - mozInstall == 1.12 07:20:00 INFO - mozcrash == 0.17 07:20:00 INFO - mozdebug == 0.1 07:20:00 INFO - mozdevice == 0.48 07:20:00 INFO - mozfile == 1.2 07:20:00 INFO - mozhttpd == 0.7 07:20:00 INFO - mozinfo == 0.9 07:20:00 INFO - mozleak == 0.1 07:20:00 INFO - mozlog == 3.1 07:20:00 INFO - moznetwork == 0.27 07:20:00 INFO - mozprocess == 0.22 07:20:00 INFO - mozprofile == 0.28 07:20:00 INFO - mozrunner == 6.11 07:20:00 INFO - mozscreenshot == 0.1 07:20:00 INFO - mozsystemmonitor == 0.0 07:20:00 INFO - moztest == 0.7 07:20:00 INFO - mozversion == 1.4 07:20:00 INFO - psutil == 3.1.1 07:20:00 INFO - requests == 1.2.3 07:20:00 INFO - wsgiref == 0.1.2 07:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20: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')]} 07:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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')]} 07:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:00 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 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:20:00 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 07:20:00 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 07:20:00 INFO - Using env: {'DISPLAY': ':0', 07:20:00 INFO - 'HOME': '/home/cltbld', 07:20:00 INFO - 'LANG': 'en_US.UTF-8', 07:20:00 INFO - 'LANGUAGE': 'en_US:en', 07:20:00 INFO - 'LOGNAME': 'cltbld', 07:20:00 INFO - 'MAIL': '/var/mail/cltbld', 07:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:00 INFO - 'MOZ_NO_REMOTE': '1', 07:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:00 INFO - 'NO_EM_RESTART': '1', 07:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:00 INFO - 'PWD': '/builds/slave/test', 07:20:00 INFO - 'SHELL': '/bin/bash', 07:20:00 INFO - 'SHLVL': '1', 07:20:00 INFO - 'TERM': 'linux', 07:20:00 INFO - 'TMOUT': '86400', 07:20:00 INFO - 'USER': 'cltbld', 07:20:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:00 INFO - '_': '/tools/buildbot/bin/python'} 07:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 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)) 07:20:00 INFO - Cleaning up... 07:20:00 INFO - Return code: 0 07:20:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:20: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')]} 07:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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')]} 07:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:00 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 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:20:00 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 07:20:00 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 07:20:00 INFO - Using env: {'DISPLAY': ':0', 07:20:00 INFO - 'HOME': '/home/cltbld', 07:20:00 INFO - 'LANG': 'en_US.UTF-8', 07:20:00 INFO - 'LANGUAGE': 'en_US:en', 07:20:00 INFO - 'LOGNAME': 'cltbld', 07:20:00 INFO - 'MAIL': '/var/mail/cltbld', 07:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:00 INFO - 'MOZ_NO_REMOTE': '1', 07:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:00 INFO - 'NO_EM_RESTART': '1', 07:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:00 INFO - 'PWD': '/builds/slave/test', 07:20:00 INFO - 'SHELL': '/bin/bash', 07:20:00 INFO - 'SHLVL': '1', 07:20:00 INFO - 'TERM': 'linux', 07:20:00 INFO - 'TMOUT': '86400', 07:20:00 INFO - 'USER': 'cltbld', 07:20:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:00 INFO - '_': '/tools/buildbot/bin/python'} 07:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:00 INFO - Downloading/unpacking jsonschema 07:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:20:02 INFO - Downloading/unpacking functools32 (from jsonschema) 07:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:20:02 INFO - warning: no files found matching '*.txt' 07:20:02 INFO - no previously-included directories found matching 'build' 07:20:02 INFO - no previously-included directories found matching 'dist' 07:20:02 INFO - no previously-included directories found matching '.git*' 07:20:02 INFO - Installing collected packages: jsonschema, functools32 07:20:02 INFO - Running setup.py install for functools32 07:20:02 INFO - warning: no files found matching '*.txt' 07:20:02 INFO - no previously-included directories found matching 'build' 07:20:02 INFO - no previously-included directories found matching 'dist' 07:20:02 INFO - no previously-included directories found matching '.git*' 07:20:02 INFO - Successfully installed jsonschema functools32 07:20:02 INFO - Cleaning up... 07:20:02 INFO - Return code: 0 07:20:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:02 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 0x7fcfc3709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', '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 07:20:02 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 07:20:02 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 07:20:02 INFO - Using env: {'DISPLAY': ':0', 07:20:02 INFO - 'HOME': '/home/cltbld', 07:20:02 INFO - 'LANG': 'en_US.UTF-8', 07:20:02 INFO - 'LANGUAGE': 'en_US:en', 07:20:02 INFO - 'LOGNAME': 'cltbld', 07:20:02 INFO - 'MAIL': '/var/mail/cltbld', 07:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:02 INFO - 'MOZ_NO_REMOTE': '1', 07:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:02 INFO - 'NO_EM_RESTART': '1', 07:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:02 INFO - 'PWD': '/builds/slave/test', 07:20:02 INFO - 'SHELL': '/bin/bash', 07:20:02 INFO - 'SHLVL': '1', 07:20:02 INFO - 'TERM': 'linux', 07:20:02 INFO - 'TMOUT': '86400', 07:20:02 INFO - 'USER': 'cltbld', 07:20:02 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:02 INFO - '_': '/tools/buildbot/bin/python'} 07:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:03 INFO - Downloading/unpacking flake8 07:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:20:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:20:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 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 07:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:20:05 INFO - no previously-included directories found matching 'docs/_build' 07:20:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:20:05 INFO - Running setup.py install for pep8 07:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:20:05 INFO - no previously-included directories found matching 'docs/_build' 07:20:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:20:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:20:05 INFO - Cleaning up... 07:20:05 INFO - Return code: 0 07:20:05 INFO - Running post-action listener: _resource_record_post_action 07:20:05 INFO - Running post-action listener: _start_resource_monitoring 07:20:05 INFO - Starting resource monitoring. 07:20:05 INFO - ##### 07:20:05 INFO - ##### Running install step. 07:20:05 INFO - ##### 07:20:05 INFO - Running pre-action listener: _resource_record_pre_action 07:20:05 INFO - Running main action method: install 07:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:06 INFO - Reading from file tmpfile_stdout 07:20:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:20:06 INFO - Reading from file tmpfile_stdout 07:20:06 INFO - Output received: 07:20:06 INFO - Usage: mozinstall [options] installer 07:20:06 INFO - Options: 07:20:06 INFO - -h, --help show this help message and exit 07:20:06 INFO - -d DEST, --destination=DEST 07:20:06 INFO - Directory to install application into. [default: 07:20:06 INFO - "/builds/slave/test"] 07:20:06 INFO - --app=APP Application being installed. [default: firefox] 07:20:06 INFO - mkdir: /builds/slave/test/build/application 07:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:20:22 INFO - Reading from file tmpfile_stdout 07:20:22 INFO - Output received: 07:20:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:20:22 INFO - Running post-action listener: _resource_record_post_action 07:20:22 INFO - ##### 07:20:22 INFO - ##### Running run-tests step. 07:20:22 INFO - ##### 07:20:22 INFO - Running pre-action listener: _resource_record_pre_action 07:20:22 INFO - Running main action method: run_tests 07:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:20:22 INFO - Python 2.7.3 07:20:22 INFO - Return code: 0 07:20:22 INFO - grabbing minidump binary from tooltool 07:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:22 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 0x16e3410>, '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 0x16e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:20:22 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 07:20:22 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 07:20:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:20:22 INFO - Return code: 0 07:20:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:20:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:20:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:20:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:20:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:20:23 INFO - Return code: 0 07:20:23 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/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 07:20:23 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/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 07:20:23 INFO - Using env: {'DISPLAY': ':0', 07:20:23 INFO - 'HOME': '/home/cltbld', 07:20:23 INFO - 'LANG': 'en_US.UTF-8', 07:20:23 INFO - 'LANGUAGE': 'en_US:en', 07:20:23 INFO - 'LOGNAME': 'cltbld', 07:20:23 INFO - 'MAIL': '/var/mail/cltbld', 07:20:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:20:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:23 INFO - 'MOZ_NO_REMOTE': '1', 07:20:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:23 INFO - 'NO_EM_RESTART': '1', 07:20:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:23 INFO - 'PWD': '/builds/slave/test', 07:20:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:20:23 INFO - 'SHELL': '/bin/bash', 07:20:23 INFO - 'SHLVL': '1', 07:20:23 INFO - 'TERM': 'linux', 07:20:23 INFO - 'TMOUT': '86400', 07:20:23 INFO - 'USER': 'cltbld', 07:20:23 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026', 07:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:23 INFO - '_': '/tools/buildbot/bin/python'} 07:20:23 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/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 07:20:24 INFO - mozversion application_buildid: 20160425043002 07:20:24 INFO - mozversion application_changeset: 1c6385ae1fe7e37d8f23f958ce14582f07af729e 07:20:24 INFO - mozversion application_display_name: Nightly 07:20:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:20:24 INFO - mozversion application_name: Firefox 07:20:24 INFO - mozversion application_remotingname: firefox 07:20:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:20:24 INFO - mozversion application_vendor: Mozilla 07:20:24 INFO - mozversion application_version: 48.0a1 07:20:24 INFO - mozversion platform_buildid: 20160425043002 07:20:24 INFO - mozversion platform_changeset: 1c6385ae1fe7e37d8f23f958ce14582f07af729e 07:20:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:20:24 INFO - mozversion platform_version: 48.0a1 07:20:24 INFO - using testdate: 1461594024 07:20:24 INFO - actual date: 1461594024 07:20:24 INFO - starting webserver on 'localhost:39085' 07:20:24 INFO - SUITE-START | Running 2 tests 07:20:24 INFO - TEST-START | dromaeo_css 07:20:24 INFO - operating with platform_type : linux_ 07:20:24 INFO - Initialising browser for dromaeo_css test... 07:20:24 INFO - TEST-INFO | started process 3328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KxxrH/profile http://localhost:39085/getInfo.html) 07:20:28 INFO - PROCESS | 3328 | 07:20:28 INFO - PROCESS | 3328 | (process:3397): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:20:29 INFO - PROCESS | 3328 | __metrics Screen width/height:1600/1200 07:20:29 INFO - PROCESS | 3328 | colorDepth:24 07:20:29 INFO - PROCESS | 3328 | Browser inner width/height: 1024/697 07:20:29 INFO - PROCESS | 3328 | __metrics 07:20:30 ERROR - PROCESS | 3328 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:20:30 INFO - TEST-INFO | 3328: exit 0 07:20:30 INFO - Browser initialized. 07:20:30 INFO - Running cycle 1/1 for dromaeo_css test... 07:20:30 INFO - TEST-INFO | started process 3448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KxxrH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:32 INFO - PROCESS | 3448 | 07:20:32 INFO - PROCESS | 3448 | (process:3509): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:20:42 INFO - PROCESS | 3448 | RSS: Main: 165179392 07:20:42 INFO - PROCESS | 3448 | 07:21:32 INFO - PROCESS | 3448 | 1461594092348 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] 07:23:40 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39085/tests/dromaeo/cssquery-ext.html) 07:23:41 INFO - PROCESS | 3448 | RSS: Main: 169664512 07:23:41 INFO - PROCESS | 3448 | 07:26:43 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-ext.html (next: http://localhost:39085/tests/dromaeo/cssquery-jquery.html) 07:26:43 INFO - PROCESS | 3448 | RSS: Main: 167112704 07:26:43 INFO - PROCESS | 3448 | 07:29:45 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39085/tests/dromaeo/cssquery-mootools.html) 07:29:46 INFO - PROCESS | 3448 | RSS: Main: 167981056 07:29:46 INFO - PROCESS | 3448 | 07:32:47 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39085/tests/dromaeo/cssquery-prototype.html) 07:32:48 INFO - PROCESS | 3448 | RSS: Main: 165453824 07:32:48 INFO - PROCESS | 3448 | 07:35:50 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39085/tests/dromaeo/cssquery-yui.html) 07:35:51 INFO - PROCESS | 3448 | RSS: Main: 166993920 07:35:51 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:39085/tests/dromaeo/cssquery-yui.html (next: http://localhost:39085/tests/dromaeo/cssquery-dojo.html) 07:38:53 INFO - PROCESS | 3448 | RSS: Main: 169000960 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | __start_tp_report 07:38:53 INFO - PROCESS | 3448 | _x_x_mozilla_page_load 07:38:53 INFO - PROCESS | 3448 | _x_x_mozilla_page_load_details 07:38:53 INFO - PROCESS | 3448 | |i|pagename|runs| 07:38:53 INFO - PROCESS | 3448 | |0;dojo.html;3130.6556278809335;3148.464760990633;3185.1081697124814;3190.569273148126;3197.440447921613;5348.384935732392;5358.67847929124;5367.731613419328;5375.6505827121255;5406.54044406226;5239.738013099349;5285.445028272034;5329.413764485904;5363.383210930744;5398.055340315449;4811.061842940628;4881.707097574139;4913.687205017135;4946.950530494703;4961.776720047588;4772.117158325704;4818.156822556056;4871.679021294968;4879.414470263556;4885.633577481685;4918.286848406961;4922.975385123087;4930.433000204951;4959.057779021974;4966.379202599675;4937.308776771219;4937.925931111036;4950.801967921278;4964.453910069889;4982.775775090094;4692.7653617319;4743.193657078271;4912.926306105412;4930.186519224324;4944.53026962438;5235.685858848481;5266.315379000744;5271.947280527184;5278.736063196825;5326.201069839555;5700.201971723962;5706.087026075849;5711.685857277889;5714.171445140473;5717.599768016241;5615.803446879339;5617.887642247173;5711.714414279311;5731.083026715705;5798.217240672498;5408.4050754416985;5415.512603865671;5415.972920135374;5417.864553386157;5435.239066530688;5839.795607153729;5882.705864706748;5883.823485295448;5895.882082358329;5938.584299099108;5482.616216864861;5621.747021384048;5644.520215781622;5710.543156547466;5725.59920805548;5721.485066344049;5736.741846616912;5740;5744.684042377709;5752.165935939265;5660.547156227574;5669.6314739541795;5670.688112153789;5699.2590963174525;5707.3721890592005;5425.647332923348;5573.386927437979;5644.125160600113;5655.123455864347;5682.062459694104;4149.751014939114;4251.766152861561;4300.182965236595;4308.482982042175;4344.109457561192;3907.27715372657;3913.0413048802657;3924.372100463912;3944.1322908959983;3980.641742243212;5217.6347655664495;5372;5459.2902922619805;5490.396056433789;5558.471945165203;5700.743466544015;5714.514266287412;5736.541076713853;5750.0512415450985;5787.855303617359;5395.3525576931015;5436.374816896028;5443.156310771837;5443.755031023614;5449.536789372868;4843.878903027382;4932.53140951609;4936.456989731127;4995.500449954975;5007.198848184273;5924.496417804448;5939.613925094942;5945.227120474311;5954.166416701665;5966.8961242170335;5718.399568045295;5734.971325143348;5739.569532285179;5745.339285982165;5746.051901436384;5849.883002340014;5850.531957443309;5958.255218097738;5966.343702192668;6020.307664618625;5652.7173641318595;5653.745581448762;5656.321241451053;5665.093585026376;5668.291463567054;5745.97127014379;5750.741216645178;5761.913571296518;5763.538916886723;5764.164196191613;5453.809116680897;5481.808136715196;5536.058869992192;5541.861453463695;5553.361363443094;5558.194061861089;5571.331440227036;5572.164175373727;5572.275604171432;5587.608867379245;5344.091504444332;5376.542993845411;5468.972655136698;5494.835154945358;5511.669299842022;5423.647462914898;5503.972480137573;5542.8337149885565;5544.140658197985;5597.720113994203;5494;5531.585131115263;5537.446255374592;5540.196671482532;5582.665040097607 07:38:53 INFO - PROCESS | 3448 | |1;ext.html;599.5832896137184;634.7905191286874;646.5764923974797;655.0240142188142;666.490135046689;35578.644213557855;36560.451593226055;36565.999999999935;36626.45060324094;36830;41223.38164927528;42148.36777448333;42223.57776422235;42424.36363454551;42436.787816060874;8563.186497282748;8696.782580435509;8724.258438032775;8744.256738177231;8761.780955476132;8587.484750914966;8673.69642062528;8680.522571258578;8708.346873984476;8733.781655458633;8653.350998675125;8686.174813392718;8727.258183054448;8735.95632021839;8742.213200811926;8617.61220745065;8689.739307820775;8714.825703485958;8722.694705685333;8727.214550690436;8576.39965202436;8696.913030869737;8711.259542938858;8713.607887645072;8722.171393717586;28979.420411591862;38728.61271387278;39128.41307380363;39248.607513924784;39255;2909.854507274628;2925.7366836984775;3064.0654600346884;3123.500239961595;3131.389379071082;28525;28701.856490717622;28744.71255287441;28907.988220412393;30124.698753012628;3847.241867043853;3848.494219278406;3911.159100793315;3953.6639385652256;4032.4152997815445;203350;204437;206301.9684901581;206570;207390;32967;51545.7422712884;52029.47970520322;52146.47853521416;52183.478165217864;34442;34476.310473790385;34554.65445345514;34686.30627387438;34773.13067173341;13919.164850109026;14017.369218385196;14145.575632731034;14162.079464834753;14173.078749881224;11845.052395808314;11845.822312665317;11853.46659400329;11910.225835320676;11977.64067077989;8390.03514595817;8500.064992850781;8583.141685831368;8642.049374568793;8658.653653853902;3318.386098571772;3325.2376240592525;3333.516640087174;3374.207061340583;3377.9359501756867;1104.8066588347008;1129.1932907348178;1129.6046383765781;1158.9652310430702;1170.4323403149465;30801.69198308033;31212.531812022837;31657.891973780806;31770.364592708018;31778.364432711216;1104.9778954467085;1142.2232881640398;1145.959891403797;1186.323795436593;1209.866914639389;17013.744793828104;17017.48947531576;17087.572810679834;17268.13659317029;17417.129143542774;457932;461046.947652616;462923;464473;466046;56088;56455.43544564502;56506.7174664124;57196.71401643049;57241.42758572444;1364.6588352911772;1366.125679565079;1394.9372278247504;1400.5728252882968;1400.7688731359415;30469.390612188075;30951.535726963662;31326.686733133287;31690.207744806565;32534.349313013136;46414.30378544392;47730.28404573865;48960.510394895595;49049;49210;424315;428310;429098;429645;429790;41665.1666966665;42243.57756422397;42565;42610.57389426066;42652;42092.36861447142;43187.78595583872;46409.53590464052;46473;48159.75920120377;38595;39555.40666889941;39588.60411395964;40607.59392406156;40853.59146408498;37296.25407491781;38171;38331;38528.42207366836;38694.22611547809;38907.22185556329;39362;39427.80286098551;39880.800595996836;40457.59542404538;33999;34250.65749342475;35445.645543545266;36061.81969090138;36220.456693150154;26656.466870662865;26999;27029.51337676368;27093.458130837666;27357.316067098483 07:38:53 INFO - PROCESS | 3448 | |2;jquery.html;396.1996766531606;397.9940300895485;401.64053172410695;402.28995822373514;402.72010952388086;17634.294628214873;18057.729134062967;18510.537236569093;18537.443876683705;18858.528536786587;18173.545661358472;18946.715799263024;19050.809491905078;19199.13603887825;19329.61340773184;5419.268398766156;5450.182472629098;5507.091329930557;5510.724463776795;5649.661020338773;5478.205660179272;5514.95215908978;5537.833864984057;5540.944590554103;5547.306586676666;5421.918671219935;5450.29146210992;5505.779768809243;5512.4211957744465;5555.916661250085;5544.0575102232715;5551.1673249012565;5552.500274975251;5576.163575463693;5576.972115139399;4743.525647435264;4990.800367985276;5005.624578156653;5024.824131155428;5031.949680503185;22165.556688866294;22427.55144897109;22427.663585046237;22654.66018009731;22808.88595557028;2247.381969958258;2347.835651504395;2375.5011447596025;2553.3106061363515;2999.4451026560155;13727.313634318343;14077.36651850659;14177.291135443289;14250.073745206528;14271.215083170422;1885.4343696890878;1996.9001549922446;2054.311805545144;2062.1957436599737;2063.030375723408;78527.60736196283;80109.59945200237;80970.59514702507;81208.18791812066;81447.18552814514;9948.651797187063;10057.446840423701;10187.185025197967;10187.54156062979;10407.271490995709;13899.818515426303;13970;13982.930085349508;14000.719985600232;14002.089864158797;7627.584042678373;7868.370530357558;7896.512598531444;7949.7217597383815;7964.840703185904;7585.544867307869;7652.693892244248;7692.384609231248;7720.189380115007;7763.573003484863;6265.686715664198;6430.967845160744;6467.32093130224;6470.547061705635;6503.7073331700185;1830.7207526629431;1835.3759721694687;1855.2300795170124;1872.1388161445616;1898.8006259342847;928.3872644055026;1057.0750593230923;1096.4956120184804;1111.9944400277948;1168.1355796710372;17503;18028.819711802975;18347.633047339245;19045;19443.4166974991;1027.7173777211326;1033.705393962717;1101.6254473479055;1101.884302148279;1121.5494145292398;10097.394156350643;10602.310849794738;10841.728956776144;10899.182561307774;10901.20780427387;475242;477558;478816;488931;500896;96975.51512242535;97659;97977.51011244899;98085;98393.50803245937;1054.2514814481651;1069.4706120470416;1079.4494807648157;1088.1621151713296;1091.8089334366455;16898.493045208663;17011.48965531036;17048.744268836224;17105.657886842444;17111.82888171152;40702.185956281304;40999.38500922429;41018;41183.382249266884;41460.37809432801;57767.422325776206;59196.40803591909;59336.703316483145;59344.406555933885;60627.09059364201;8124.146964568871;8334.6666133354;8481.321494280319;8526.062133165471;8624.913750862412;9614.95192524033;11964.940175299067;12791.488340466278;12945.158564693265;13188.736225275248;10549.841752373874;12089.335086570323;12131.393430328624;12194.817077743663;12287.324197169242;10630.787384252117;11641;11724.70688232801;11770.117241206772;11987.64037078889;11881.702957426134;12148.817767733668;12205.20666156697;12298.139130260795;12323.753524929272;7865.488743231672;8241.876371854547;8328.875066874123;8373.33013358942;8561.657533698582;8554.358423118416;11819.763604728028;11922.284662920252;12140.575079872162;12282.385880706108 07:38:53 INFO - PROCESS | 3448 | |3;mootools.html;1467.5303902751118;1501.9098854068754;1613.419169099124;1714.237164461815;1717.6908156531827;7377.594232317234;7960.203979602037;7992.92007079929;8252.00975882894;8275.337972962163;7960.681572737083;7968.083670377909;8012.719554815582;8041.91958080419;8064.71773487928;2214.4795972946386;2272.9090836366527;2274.7042884425;2280.4754906371545;2284.9543009139807;2203.537257175995;2206.106526856626;2223.7665045170265;2226.421130506072;2241.674957131215;2190.233418303589;2202.7576966533748;2217.3126330837413;2271.6706077618737;2298.0233400804673;2160.168335190955;2164.8701077935375;2165.1988764157204;2176.597329494041;2177.1835561664375;2118.798714122156;2126.3514628038442;2127.0747224957195;2129.744430668314;2138.027197625077;8143.470674406145;8227.588620568948;8231.547264900428;8233.259006689426;8240.13478584746;4833.32333473314;5004.474530174352;5007.349044624176;5037;5041.647084704072;2908.200244932639;2935;2968;2984.3136078701805;2988.4023195360796;963.3352986439335;972.3922548407245;976.6581696406272;987.2694206287296;996.1482932093029;11047.558097676083;11157.944210278896;11183.32900026001;11185.49665265065;11206.607768728138;4408.58118478744;4413.3821265022925;4468.932966005513;4493.326001099861;4512.120136573402;9441.291903107294;9442.527873606292;9502.524873756285;9525.476098814494;9546.284028697875;4830.058138662927;4862.927056094161;4872.4883887192045;4877.341558889504;4982.576480999156;4120.484939382577;4505.414296141546;4514.977425112854;4584.518625544337;4642.976785116053;3753.8310776015146;3773.905652358713;3830.291396091732;3847;3883.359245724424;1172.783035138502;1264.3551788587702;1265.943032563537;1267.1383459247616;1274.4965738533228;934.444005816538;936.2322895225985;949.0604301741226;956.2015716876347;958.4105774948496;5243.318368612056;5320.787168513216;5329.813456529003;5401.243825864382;5541.972290138524;408.2040021957195;411.1222539877383;411.9824034634448;412.07900342733967;981.283662926068;3954.307996100671;4142.357934520094;4153.979230103831;4160.91678166441;4222.176675548239;10378.636747713794;10727.892721072845;10825.242233043611;10846.837297440545;10862.348259104321;10191.082802547806;10384.636537721295;10494.580216791395;10499.265051446326;10546.736331591772;7989.320907722792;8039.075506316848;8049.798755031171;8089.069756978023;8214.342852571779;5822.94177058224;5901.29184497863;5980.192673988956;5989.940100598938;6093.725782339717;9622;9687.128158465772;9872.829481574016;9926.602935882773;9937.10566049059;9976.2517811163;10070.8489372658;10197.23520735933;10295.227857910537;10303.948480257552;6566.868662626816;6960.686769095301;7168.139823221247;7214.855702886018;7353.852922941618;7801.2198780121535;7839;7842.725504607311;7869.291763741291;7890.881636775338;6992.9860170274005;7133.2153463117975;7139.535930164523;7232.566046037255;7250.854982900207;7082.5396349237135;7092.290770922867;7113;7172.677229524579;7197.784066478014;6708.161479815023;7054.153501579844;7056.188538318159;7058.082449281561;7061.717531298896;4903.60771138301;5030.446650868328;5045.066662667418;5080.974595127001;5127.256547800623;5116.258142569232;5154.9732529675575;5207.4271830099415;5311.2829767982375;5335.039692855324 07:38:53 INFO - PROCESS | 3448 | |4;prototype.html;303.3114829337404;313.850920812614;314.1674562409614;314.3383178409447;316.2631069607814;5351.093701597836;5480.561555075595;5506.146547285167;5557.194206840006;5602.478884501975;5522.502974732273;5522.861928451791;5536.307961504812;5541.473560011803;5547.33431988161;4210.221109094812;4246.893827654302;4258.680598955075;4273.807678654468;4290.120525292323;4205.747655140686;4292.742435453867;4303.526612072686;4303.655707543405;4318.956810431887;4168.145530166309;4225.154969006211;4226.535081141072;4237.809298581571;4244.27847265964;4187.51843537994;4222.619964203221;4235.216484950279;4238.364245363189;4239.957600423987;3623.927521449556;3685.4471829225563;3687.1888184599347;3690.0959264979983;3713;5296.655717378397;5356.785728570852;5362.115250983583;5363.812266570651;5370.5435038021815;4807.879803004953;4858.927116093261;4874.780634871439;4883.438404583483;4885.853424397274;5558.86102847428;5663.716814159276;5716;5781.13283007548;5782.45066718661;4018.5378681451716;4037.1723796621623;4042.272390969624;4051.675865930748;4056.1482088761395;6053.213082299317;6059.242594675666;6074.787382441637;6083.8174854754425;6108.297545782203;4016.674497415846;4038.7172897896867;4120.608542188487;4126.855560055384;4149.564295748964;4160.084781348099;4177.498700156001;4177.791110444466;4181.623653871166;4204.66362690984;4831.767899185686;4832.685875418087;4835.6131509479155;4856.6886940526565;4858.562729354305;5652;5863.651360187181;5875.500582450454;5880.147378630075;5898.4101589840675;1483.6810085831382;1489.9346966918488;1498.2883130513137;1500.9699806003819;1504.9774253386208;935.1583574782615;965.6716716316486;966.7873067925045;981.548487695668;985.9063388978036;5991.824333103462;5992.280926288786;6002.789902353396;6017.2779266488305;6033.909491357633;6280.623162610258;6333.493320534346;6341.524385671093;6343.794679010974;6368.331325210879;5399.352077750695;5737.799177028784;5747.453991870766;5805.477507024388;5937.52499800015;3425.246445781924;3445.4323282906216;3446.1556918555116;3448.413769659164;3454.8790792322147;6467.4179323860135;6626.834329141713;6646.567973081735;6709.194896612437;6728;6511.511636627272;6544.280129185786;6551.443127334134;6555.541112122201;6577.736890524326;6445.132835768931;6635.701393437307;6686.364795344434;6705.932940670531;6722.731090756315;6375.713092910737;6383.39357761012;6401.7119229633845;6403;6449.645269510222;6337.144485494584;6355.173827402408;6413.775517856852;6414.935850641434;6425.710843011982;6027.126066720389;6318.968405158129;6358.554901156875;6370.362963703593;6386.137871387304;3863.652271295597;3940.802959851939;4057.289974254553;4080.285949958805;4086.81609327575;6007.459328660441;6045;6060.606060606046;6071.119687645179;6082.90875636857;5724.942750572441;5775.249217601685;5855.121731740273;5860.062390017577;5890.3226128994;5814.680192589448;5819.127130930225;5831.250624812624;5835.56233282514;5840.853978650568;5683.9715801420725;5728.627639203439;5755.7122143893475;5767.538596912321;5806.332271788799;5687.516561092353;5749.8562535936935;5796.652200867793;5811.738471768696;5844.1525978732;5681.9431805681415;5722.141678748221;5728.338781753245;5740.13897915316;5767.452092051249 07:38:53 INFO - PROCESS | 3448 | |5;yui.html;669.5948950884715;686.2931180883688;692.6779047742799;714.4748609771817;728.1117037214597;12273.263604183756;12578.622641320764;13320.067595268323;13525.661858453544;13564.457421703144;13020.60938171854;13155.210687358765;13192.472301107968;13194.868051319483;13294.800577991338;777.953322800631;790.4071946040469;790.9050913890312;793.0404210904812;794.4835856693138;662.7978466567695;778.4550814429894;780.9765707028798;793.896793416855;799.1648727080216;811.6996711216858;814.9796255093611;819.2585709932491;819.573821612761;821.9465734727254;804.0913767442811;812.5003123079323;812.5165526511776;818.4639061414783;818.9140140285274;591.8461200087966;592.1946153231602;593.9287285525764;596.3916804859019;601.3114983344091;12684.556040538537;12720.363981800872;12729.618111456672;12747.553835615709;12842.871571284355;12541.811872821914;12776.680582985407;12792.360381980863;13118.212907225598;13297.933510332483;9944.70165895017;10191.133753630951;10215.948920255425;10282.845757313646;10305;3719;3766.5291838520184;3822.1591249924973;3847;3864.652181303696;55720.721396393164;55893.44106558923;56094;56484;56678.71660641712;9540;9717.61129554824;9767;9791.461469619097;9824.263180261367;17930.19314130867;18030.729539056923;18040.819591803913;18067.45797626073;18080.095995200187;7771.572563509061;7794.493357931717;7795.376369890509;8014.519128852287;8075.959620201861;4482.731036137842;4507.752073635916;4540.931886021713;4557.156925968707;4592.931106033412;2928.1654728402727;2970.7177818107243;3000.204945689394;3005.173577266269;3015.050259168355;565.6860442454478;591.9970400148057;592.7006861534984;597.4055814464635;598.9401059893976;656.7274581048811;672.9831754206086;688.4561196654687;704.8097013806243;755.3390783064818;9095.909040909639;9106.635734570544;9141.588628511732;9188.219001384823;9478.90521094794;678.9762358317436;690.5925503952692;701.919279282889;759.472166844038;761.6420282467232;4201.432806571135;4264.0385422705285;4288.228118938621;4328.004558951458;4366.345048242789;67933;70706;70798.64600676963;71750.28249717435;71995;59464.70267648634;60229;60369.698151508965;60933.695331523944;61081.043367321014;51709;54656.90686186254;54759.178612320844;55053.174202386996;55857.720711396185;9405.247580193705;9412.717618471457;9533.332666713264;9607.759806004626;9609.231261498924;34769.47845782366;35202.29595408129;35866.46200306945;36143.81928090343;36299.63700362963;44283.77858110689;47713.28430073482;48596.27105593348;48837.75581122214;49216;11552.768944620891;11616.767664646828;11796.646100616996;11806.940965295118;12040.277583345027;12851.357432128543;12965.611031669065;13008.479660813462;13184.73630527365;13281;11491.597794077166;11796.882031179579;11867.347295898808;12280.263184208976;12604.11771176009;11945.641630751092;12204.938975305422;12243.938780306042;12270.509179632714;12275.447604857623;10154.289199755945;11552.6534203974;11793.52825886955;11821.763564728486;12553.49786008586;10090.69727908164;10514.631987880388;10613.628523001658;10829.458527073457;10851;10293;10684.46577671129;10701.732456688645;10918.727031824268;10935.671929842118 07:38:53 INFO - PROCESS | 3448 | __end_tp_report 07:38:53 INFO - PROCESS | 3448 | __start_cc_report 07:38:53 INFO - PROCESS | 3448 | _x_x_mozilla_cycle_collect,355 07:38:53 INFO - PROCESS | 3448 | __end_cc_report 07:38:53 INFO - PROCESS | 3448 | __startTimestamp1461595133828__endTimestamp 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | ------- Summary: start ------- 07:38:53 INFO - PROCESS | 3448 | Number of tests: 6 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | [#0] dojo.html Cycles:165 Average:5313.50 Median:5494.00 stddev:592.79 (10.8%) stddev-sans-first:569.34 07:38:53 INFO - PROCESS | 3448 | Values: 3130.7 3148.5 3185.1 3190.6 3197.4 5348.4 5358.7 5367.7 5375.7 5406.5 5239.7 5285.4 5329.4 5363.4 5398.1 4811.1 4881.7 4913.7 4947.0 4961.8 4772.1 4818.2 4871.7 4879.4 4885.6 4918.3 4923.0 4930.4 4959.1 4966.4 4937.3 4937.9 4950.8 4964.5 4982.8 4692.8 4743.2 4912.9 4930.2 4944.5 5235.7 5266.3 5271.9 5278.7 5326.2 5700.2 5706.1 5711.7 5714.2 5717.6 5615.8 5617.9 5711.7 5731.1 5798.2 5408.4 5415.5 5416.0 5417.9 5435.2 5839.8 5882.7 5883.8 5895.9 5938.6 5482.6 5621.7 5644.5 5710.5 5725.6 5721.5 5736.7 5740.0 5744.7 5752.2 5660.5 5669.6 5670.7 5699.3 5707.4 5425.6 5573.4 5644.1 5655.1 5682.1 4149.8 4251.8 4300.2 4308.5 4344.1 3907.3 3913.0 3924.4 3944.1 3980.6 5217.6 5372.0 5459.3 5490.4 5558.5 5700.7 5714.5 5736.5 5750.1 5787.9 5395.4 5436.4 5443.2 5443.8 5449.5 4843.9 4932.5 4936.5 4995.5 5007.2 5924.5 5939.6 5945.2 5954.2 5966.9 5718.4 5735.0 5739.6 5745.3 5746.1 5849.9 5850.5 5958.3 5966.3 6020.3 5652.7 5653.7 5656.3 5665.1 5668.3 5746.0 5750.7 5761.9 5763.5 5764.2 5453.8 5481.8 5536.1 5541.9 5553.4 5558.2 5571.3 5572.2 5572.3 5587.6 5344.1 5376.5 5469.0 5494.8 5511.7 5423.6 5504.0 5542.8 5544.1 5597.7 5494.0 5531.6 5537.4 5540.2 5582.7 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | [#1] ext.html Cycles:180 Average:51909.43 Median:38817.92 stddev:101737.11 (262.1%) stddev-sans-first:101949.57 07:38:53 INFO - PROCESS | 3448 | Values: 599.6 634.8 646.6 655.0 666.5 35578.6 36560.5 36566.0 36626.5 36830.0 41223.4 42148.4 42223.6 42424.4 42436.8 8563.2 8696.8 8724.3 8744.3 8761.8 8587.5 8673.7 8680.5 8708.3 8733.8 8653.4 8686.2 8727.3 8736.0 8742.2 8617.6 8689.7 8714.8 8722.7 8727.2 8576.4 8696.9 8711.3 8713.6 8722.2 28979.4 38728.6 39128.4 39248.6 39255.0 2909.9 2925.7 3064.1 3123.5 3131.4 28525.0 28701.9 28744.7 28908.0 30124.7 3847.2 3848.5 3911.2 3953.7 4032.4 203350.0 204437.0 206302.0 206570.0 207390.0 32967.0 51545.7 52029.5 52146.5 52183.5 34442.0 34476.3 34554.7 34686.3 34773.1 13919.2 14017.4 14145.6 14162.1 14173.1 11845.1 11845.8 11853.5 11910.2 11977.6 8390.0 8500.1 8583.1 8642.0 8658.7 3318.4 3325.2 3333.5 3374.2 3377.9 1104.8 1129.2 1129.6 1159.0 1170.4 30801.7 31212.5 31657.9 31770.4 31778.4 1105.0 1142.2 1146.0 1186.3 1209.9 17013.7 17017.5 17087.6 17268.1 17417.1 457932.0 461046.9 462923.0 464473.0 466046.0 56088.0 56455.4 56506.7 57196.7 57241.4 1364.7 1366.1 1394.9 1400.6 1400.8 30469.4 30951.5 31326.7 31690.2 32534.3 46414.3 47730.3 48960.5 49049.0 49210.0 424315.0 428310.0 429098.0 429645.0 429790.0 41665.2 42243.6 42565.0 42610.6 42652.0 42092.4 43187.8 46409.5 46473.0 48159.8 38595.0 39555.4 39588.6 40607.6 40853.6 37296.3 38171.0 38331.0 38528.4 38694.2 38907.2 39362.0 39427.8 39880.8 40457.6 33999.0 34250.7 35445.6 36061.8 36220.5 26656.5 26999.0 27029.5 27093.5 27357.3 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | [#2] jquery.html Cycles:180 Average:28938.16 Median:22731.77 stddev:80036.94 (352.1%) stddev-sans-first:80232.78 07:38:53 INFO - PROCESS | 3448 | Values: 396.2 398.0 401.6 402.3 402.7 17634.3 18057.7 18510.5 18537.4 18858.5 18173.5 18946.7 19050.8 19199.1 19329.6 5419.3 5450.2 5507.1 5510.7 5649.7 5478.2 5515.0 5537.8 5540.9 5547.3 5421.9 5450.3 5505.8 5512.4 5555.9 5544.1 5551.2 5552.5 5576.2 5577.0 4743.5 4990.8 5005.6 5024.8 5031.9 22165.6 22427.6 22427.7 22654.7 22808.9 2247.4 2347.8 2375.5 2553.3 2999.4 13727.3 14077.4 14177.3 14250.1 14271.2 1885.4 1996.9 2054.3 2062.2 2063.0 78527.6 80109.6 80970.6 81208.2 81447.2 9948.7 10057.4 10187.2 10187.5 10407.3 13899.8 13970.0 13982.9 14000.7 14002.1 7627.6 7868.4 7896.5 7949.7 7964.8 7585.5 7652.7 7692.4 7720.2 7763.6 6265.7 6431.0 6467.3 6470.5 6503.7 1830.7 1835.4 1855.2 1872.1 1898.8 928.4 1057.1 1096.5 1112.0 1168.1 17503.0 18028.8 18347.6 19045.0 19443.4 1027.7 1033.7 1101.6 1101.9 1121.5 10097.4 10602.3 10841.7 10899.2 10901.2 475242.0 477558.0 478816.0 488931.0 500896.0 96975.5 97659.0 97977.5 98085.0 98393.5 1054.3 1069.5 1079.4 1088.2 1091.8 16898.5 17011.5 17048.7 17105.7 17111.8 40702.2 40999.4 41018.0 41183.4 41460.4 57767.4 59196.4 59336.7 59344.4 60627.1 8124.1 8334.7 8481.3 8526.1 8624.9 9615.0 11964.9 12791.5 12945.2 13188.7 10549.8 12089.3 12131.4 12194.8 12287.3 10630.8 11641.0 11724.7 11770.1 11987.6 11881.7 12148.8 12205.2 12298.1 12323.8 7865.5 8241.9 8328.9 8373.3 8561.7 8554.4 11819.8 11922.3 12140.6 12282.4 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | [#3] mootools.html Cycles:180 Average:5495.37 Median:5005.91 stddev:3127.92 (62.5%) stddev-sans-first:3122.05 07:38:53 INFO - PROCESS | 3448 | Values: 1467.5 1501.9 1613.4 1714.2 1717.7 7377.6 7960.2 7992.9 8252.0 8275.3 7960.7 7968.1 8012.7 8041.9 8064.7 2214.5 2272.9 2274.7 2280.5 2285.0 2203.5 2206.1 2223.8 2226.4 2241.7 2190.2 2202.8 2217.3 2271.7 2298.0 2160.2 2164.9 2165.2 2176.6 2177.2 2118.8 2126.4 2127.1 2129.7 2138.0 8143.5 8227.6 8231.5 8233.3 8240.1 4833.3 5004.5 5007.3 5037.0 5041.6 2908.2 2935.0 2968.0 2984.3 2988.4 963.3 972.4 976.7 987.3 996.1 11047.6 11157.9 11183.3 11185.5 11206.6 4408.6 4413.4 4468.9 4493.3 4512.1 9441.3 9442.5 9502.5 9525.5 9546.3 4830.1 4862.9 4872.5 4877.3 4982.6 4120.5 4505.4 4515.0 4584.5 4643.0 3753.8 3773.9 3830.3 3847.0 3883.4 1172.8 1264.4 1265.9 1267.1 1274.5 934.4 936.2 949.1 956.2 958.4 5243.3 5320.8 5329.8 5401.2 5542.0 408.2 411.1 412.0 412.1 981.3 3954.3 4142.4 4154.0 4160.9 4222.2 10378.6 10727.9 10825.2 10846.8 10862.3 10191.1 10384.6 10494.6 10499.3 10546.7 7989.3 8039.1 8049.8 8089.1 8214.3 5822.9 5901.3 5980.2 5989.9 6093.7 9622.0 9687.1 9872.8 9926.6 9937.1 9976.3 10070.8 10197.2 10295.2 10303.9 6566.9 6960.7 7168.1 7214.9 7353.9 7801.2 7839.0 7842.7 7869.3 7890.9 6993.0 7133.2 7139.5 7232.6 7250.9 7082.5 7092.3 7113.0 7172.7 7197.8 6708.2 7054.2 7056.2 7058.1 7061.7 4903.6 5030.4 5045.1 5081.0 5127.3 5116.3 5155.0 5207.4 5311.3 5335.0 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | [#4] prototype.html Cycles:180 Average:4967.58 Median:5685.74 stddev:1534.57 (27.0%) stddev-sans-first:1498.41 07:38:53 INFO - PROCESS | 3448 | Values: 303.3 313.9 314.2 314.3 316.3 5351.1 5480.6 5506.1 5557.2 5602.5 5522.5 5522.9 5536.3 5541.5 5547.3 4210.2 4246.9 4258.7 4273.8 4290.1 4205.7 4292.7 4303.5 4303.7 4319.0 4168.1 4225.2 4226.5 4237.8 4244.3 4187.5 4222.6 4235.2 4238.4 4240.0 3623.9 3685.4 3687.2 3690.1 3713.0 5296.7 5356.8 5362.1 5363.8 5370.5 4807.9 4858.9 4874.8 4883.4 4885.9 5558.9 5663.7 5716.0 5781.1 5782.5 4018.5 4037.2 4042.3 4051.7 4056.1 6053.2 6059.2 6074.8 6083.8 6108.3 4016.7 4038.7 4120.6 4126.9 4149.6 4160.1 4177.5 4177.8 4181.6 4204.7 4831.8 4832.7 4835.6 4856.7 4858.6 5652.0 5863.7 5875.5 5880.1 5898.4 1483.7 1489.9 1498.3 1501.0 1505.0 935.2 965.7 966.8 981.5 985.9 5991.8 5992.3 6002.8 6017.3 6033.9 6280.6 6333.5 6341.5 6343.8 6368.3 5399.4 5737.8 5747.5 5805.5 5937.5 3425.2 3445.4 3446.2 3448.4 3454.9 6467.4 6626.8 6646.6 6709.2 6728.0 6511.5 6544.3 6551.4 6555.5 6577.7 6445.1 6635.7 6686.4 6705.9 6722.7 6375.7 6383.4 6401.7 6403.0 6449.6 6337.1 6355.2 6413.8 6414.9 6425.7 6027.1 6319.0 6358.6 6370.4 6386.1 3863.7 3940.8 4057.3 4080.3 4086.8 6007.5 6045.0 6060.6 6071.1 6082.9 5724.9 5775.2 5855.1 5860.1 5890.3 5814.7 5819.1 5831.3 5835.6 5840.9 5684.0 5728.6 5755.7 5767.5 5806.3 5687.5 5749.9 5796.7 5811.7 5844.2 5681.9 5722.1 5728.3 5740.1 5767.5 07:38:53 INFO - PROCESS | 3448 | 07:38:53 INFO - PROCESS | 3448 | [#5] yui.html Cycles:180 Average:15150.51 Median:48154.78 stddev:18696.27 (38.8%) stddev-sans-first:18717.10 07:38:53 INFO - PROCESS | 3448 | Values: 669.6 686.3 692.7 714.5 728.1 12273.3 12578.6 13320.1 13525.7 13564.5 13020.6 13155.2 13192.5 13194.9 13294.8 778.0 790.4 790.9 793.0 794.5 662.8 778.5 781.0 793.9 799.2 811.7 815.0 819.3 819.6 821.9 804.1 812.5 812.5 818.5 818.9 591.8 592.2 593.9 596.4 601.3 12684.6 12720.4 12729.6 12747.6 12842.9 12541.8 12776.7 12792.4 13118.2 13297.9 9944.7 10191.1 10215.9 10282.8 10305.0 3719.0 3766.5 3822.2 3847.0 3864.7 55720.7 55893.4 56094.0 56484.0 56678.7 9540.0 9717.6 9767.0 9791.5 9824.3 17930.2 18030.7 18040.8 18067.5 18080.1 7771.6 7794.5 7795.4 8014.5 8076.0 4482.7 4507.8 4540.9 4557.2 4592.9 2928.2 2970.7 3000.2 3005.2 3015.1 565.7 592.0 592.7 597.4 598.9 656.7 673.0 688.5 704.8 755.3 9095.9 9106.6 9141.6 9188.2 9478.9 679.0 690.6 701.9 759.5 761.6 4201.4 4264.0 4288.2 4328.0 4366.3 67933.0 70706.0 70798.6 71750.3 71995.0 59464.7 60229.0 60369.7 60933.7 61081.0 51709.0 54656.9 54759.2 55053.2 55857.7 9405.2 9412.7 9533.3 9607.8 9609.2 34769.5 35202.3 35866.5 36143.8 36299.6 44283.8 47713.3 48596.3 48837.8 49216.0 11552.8 11616.8 11796.6 11806.9 12040.3 12851.4 12965.6 13008.5 13184.7 13281.0 11491.6 11796.9 11867.3 12280.3 12604.1 11945.6 12204.9 12243.9 12270.5 12275.4 10154.3 11552.7 11793.5 11821.8 12553.5 10090.7 10514.6 10613.6 10829.5 10851.0 10293.0 10684.5 10701.7 10918.7 10935.7 07:38:53 INFO - PROCESS | 3448 | -------- Summary: end -------- 07:38:53 INFO - PROCESS | 3448 | 07:38:54 INFO - TEST-INFO | 3448: exit 0 07:38:54 INFO - TEST-OK | dromaeo_css | took 1110259ms 07:38:54 INFO - TEST-START | kraken 07:38:54 INFO - operating with platform_type : linux_ 07:38:54 INFO - Initialising browser for kraken test... 07:38:54 INFO - TEST-INFO | started process 3720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgMtPWx/profile http://localhost:39085/getInfo.html) 07:38:58 INFO - PROCESS | 3720 | 07:38:58 INFO - PROCESS | 3720 | (process:3791): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:38:58 INFO - PROCESS | 3720 | __metrics Screen width/height:1600/1200 07:38:58 INFO - PROCESS | 3720 | colorDepth:24 07:38:58 INFO - PROCESS | 3720 | Browser inner width/height: 1024/697 07:38:58 INFO - PROCESS | 3720 | __metrics 07:38:59 ERROR - PROCESS | 3720 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:39:00 INFO - TEST-INFO | 3720: exit 0 07:39:00 INFO - Browser initialized. 07:39:00 INFO - Running cycle 1/1 for kraken test... 07:39:00 INFO - TEST-INFO | started process 3842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgMtPWx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:02 INFO - PROCESS | 3842 | 07:39:02 INFO - PROCESS | 3842 | (process:3904): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:39:12 INFO - PROCESS | 3842 | RSS: Main: 164646912 07:39:12 INFO - PROCESS | 3842 | 07:39:14 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-beat-detection) 07:39:15 INFO - PROCESS | 3842 | RSS: Main: 169512960 07:39:15 INFO - PROCESS | 3842 | 07:39:18 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-dft) 07:39:18 INFO - PROCESS | 3842 | RSS: Main: 173297664 07:39:18 INFO - PROCESS | 3842 | 07:39:21 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-fft) 07:39:22 INFO - PROCESS | 3842 | RSS: Main: 164712448 07:39:22 INFO - PROCESS | 3842 | 07:39:24 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39085/tests/kraken/driver.html?testName=audio-oscillator) 07:39:25 INFO - PROCESS | 3842 | RSS: Main: 164765696 07:39:25 INFO - PROCESS | 3842 | 07:39:27 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:39:28 INFO - PROCESS | 3842 | RSS: Main: 165191680 07:39:28 INFO - PROCESS | 3842 | 07:39:31 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39085/tests/kraken/driver.html?testName=imaging-darkroom) 07:39:32 INFO - PROCESS | 3842 | RSS: Main: 165380096 07:39:32 INFO - PROCESS | 3842 | 07:39:35 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39085/tests/kraken/driver.html?testName=imaging-desaturate) 07:39:36 INFO - PROCESS | 3842 | RSS: Main: 167563264 07:39:36 INFO - PROCESS | 3842 | 07:39:38 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39085/tests/kraken/driver.html?testName=json-parse-financial) 07:39:39 INFO - PROCESS | 3842 | RSS: Main: 167784448 07:39:39 INFO - PROCESS | 3842 | 07:39:41 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:39:41 INFO - PROCESS | 3842 | RSS: Main: 167739392 07:39:41 INFO - PROCESS | 3842 | 07:39:43 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:39:44 INFO - PROCESS | 3842 | RSS: Main: 167526400 07:39:44 INFO - PROCESS | 3842 | 07:39:46 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:39:47 INFO - PROCESS | 3842 | RSS: Main: 168357888 07:39:47 INFO - PROCESS | 3842 | 07:39:49 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:50 INFO - PROCESS | 3842 | RSS: Main: 168132608 07:39:50 INFO - PROCESS | 3842 | 07:39:53 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:53 INFO - PROCESS | 3842 | RSS: Main: 168136704 07:39:53 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:39085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39085/tests/kraken/driver.html?testName=ai-astar) 07:39:55 INFO - PROCESS | 3842 | RSS: Main: 169566208 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | __start_tp_report 07:39:55 INFO - PROCESS | 3842 | _x_x_mozilla_page_load 07:39:55 INFO - PROCESS | 3842 | _x_x_mozilla_page_load_details 07:39:55 INFO - PROCESS | 3842 | |i|pagename|runs| 07:39:55 INFO - PROCESS | 3842 | |0;ai-astar;113;105;112;110;111;123;110;109;110;110 07:39:55 INFO - PROCESS | 3842 | |1;audio-beat-detection;160;130;161;191;127;154;162;131;186;132 07:39:55 INFO - PROCESS | 3842 | |2;audio-dft;167;162;163;163;165;166;175;162;164;164 07:39:55 INFO - PROCESS | 3842 | |3;audio-fft;73;73;73;154;77;76;85;77;167;77 07:39:55 INFO - PROCESS | 3842 | |4;audio-oscillator;93;92;157;93;93;93;149;93;93;143 07:39:55 INFO - PROCESS | 3842 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;122;118;117 07:39:55 INFO - PROCESS | 3842 | |6;imaging-darkroom;145;147;147;146;146;146;146;146;146;147 07:39:55 INFO - PROCESS | 3842 | |7;imaging-desaturate;100;95;95;95;96;95;96;95;100;95 07:39:55 INFO - PROCESS | 3842 | |8;json-parse-financial;58;59;63;59;60;61;59;82;57;55 07:39:55 INFO - PROCESS | 3842 | |9;json-stringify-tinderbox;60;61;60;61;62;64;60;61;66;61 07:39:55 INFO - PROCESS | 3842 | |10;stanford-crypto-aes;77;77;84;76;77;78;81;77;86;79 07:39:55 INFO - PROCESS | 3842 | |11;stanford-crypto-ccm;129;124;134;128;124;124;131;132;207;123 07:39:55 INFO - PROCESS | 3842 | |12;stanford-crypto-pbkdf2;167;167;171;168;165;167;168;168;169;164 07:39:55 INFO - PROCESS | 3842 | |13;stanford-crypto-sha256-iterative;69;68;70;68;69;66;73;68;67;67 07:39:55 INFO - PROCESS | 3842 | __end_tp_report 07:39:55 INFO - PROCESS | 3842 | __start_cc_report 07:39:55 INFO - PROCESS | 3842 | _x_x_mozilla_cycle_collect,861 07:39:55 INFO - PROCESS | 3842 | __end_cc_report 07:39:55 INFO - PROCESS | 3842 | __startTimestamp1461595195760__endTimestamp 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | ------- Summary: start ------- 07:39:55 INFO - PROCESS | 3842 | Number of tests: 14 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#0] ai-astar Cycles:10 Average:111.30 Median:110.50 stddev:4.62 (4.2%) stddev-sans-first:4.86 07:39:55 INFO - PROCESS | 3842 | Values: 113.0 105.0 112.0 110.0 111.0 123.0 110.0 109.0 110.0 110.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:160.50 stddev:23.23 (14.5%) stddev-sans-first:24.52 07:39:55 INFO - PROCESS | 3842 | Values: 160.0 130.0 161.0 191.0 127.0 154.0 162.0 131.0 186.0 132.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.84 (2.3%) stddev-sans-first:4.01 07:39:55 INFO - PROCESS | 3842 | Values: 167.0 162.0 163.0 163.0 165.0 166.0 175.0 162.0 164.0 164.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.50 stddev:35.77 (46.8%) stddev-sans-first:37.19 07:39:55 INFO - PROCESS | 3842 | Values: 73.0 73.0 73.0 154.0 77.0 76.0 85.0 77.0 167.0 77.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.64 (29.7%) stddev-sans-first:28.63 07:39:55 INFO - PROCESS | 3842 | Values: 93.0 92.0 157.0 93.0 93.0 93.0 149.0 93.0 93.0 143.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.50 stddev:1.55 (1.3%) stddev-sans-first:1.64 07:39:55 INFO - PROCESS | 3842 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 122.0 118.0 117.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 07:39:55 INFO - PROCESS | 3842 | Values: 145.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.00 stddev:2.04 (2.2%) stddev-sans-first:1.64 07:39:55 INFO - PROCESS | 3842 | Values: 100.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 100.0 95.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:59.50 stddev:7.59 (12.8%) stddev-sans-first:7.95 07:39:55 INFO - PROCESS | 3842 | Values: 58.0 59.0 63.0 59.0 60.0 61.0 59.0 82.0 57.0 55.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.96 (3.2%) stddev-sans-first:1.99 07:39:55 INFO - PROCESS | 3842 | Values: 60.0 61.0 60.0 61.0 62.0 64.0 60.0 61.0 66.0 61.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.50 stddev:3.39 (4.3%) stddev-sans-first:3.50 07:39:55 INFO - PROCESS | 3842 | Values: 77.0 77.0 84.0 76.0 77.0 78.0 81.0 77.0 86.0 79.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:130.00 stddev:25.38 (19.5%) stddev-sans-first:26.81 07:39:55 INFO - PROCESS | 3842 | Values: 129.0 124.0 134.0 128.0 124.0 124.0 131.0 132.0 207.0 123.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.00 stddev:1.96 (1.2%) stddev-sans-first:2.07 07:39:55 INFO - PROCESS | 3842 | Values: 167.0 167.0 171.0 168.0 165.0 167.0 168.0 168.0 169.0 164.0 07:39:55 INFO - PROCESS | 3842 | 07:39:55 INFO - PROCESS | 3842 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.96 (2.9%) stddev-sans-first:2.07 07:39:55 INFO - PROCESS | 3842 | Values: 69.0 68.0 70.0 68.0 69.0 66.0 73.0 68.0 67.0 67.0 07:39:55 INFO - PROCESS | 3842 | -------- Summary: end -------- 07:39:55 INFO - PROCESS | 3842 | 07:39:56 INFO - TEST-INFO | 3842: exit 0 07:39:56 INFO - TEST-OK | kraken | took 62271ms 07:39:56 INFO - SUITE-END | took 1172s 07:39:56 INFO - Completed test suite (00:19:32) 07:39:56 INFO - javascript benchmark 07:39:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.6556278809335, 3148.464760990633, 3185.1081697124814, 3190.569273148126, 3197.440447921613, 5348.384935732392, 5358.67847929124, 5367.731613419328, 5375.6505827121255, 5406.54044406226, 5239.738013099349, 5285.445028272034, 5329.413764485904, 5363.383210930744, 5398.055340315449, 4811.061842940628, 4881.707097574139, 4913.687205017135, 4946.950530494703, 4961.776720047588, 4772.117158325704, 4818.156822556056, 4871.679021294968, 4879.414470263556, 4885.633577481685, 4918.286848406961, 4922.975385123087, 4930.433000204951, 4959.057779021974, 4966.379202599675, 4937.308776771219, 4937.925931111036, 4950.801967921278, 4964.453910069889, 4982.775775090094, 4692.7653617319, 4743.193657078271, 4912.926306105412, 4930.186519224324, 4944.53026962438, 5235.685858848481, 5266.315379000744, 5271.947280527184, 5278.736063196825, 5326.201069839555, 5700.201971723962, 5706.087026075849, 5711.685857277889, 5714.171445140473, 5717.599768016241, 5615.803446879339, 5617.887642247173, 5711.714414279311, 5731.083026715705, 5798.217240672498, 5408.4050754416985, 5415.512603865671, 5415.972920135374, 5417.864553386157, 5435.239066530688, 5839.795607153729, 5882.705864706748, 5883.823485295448, 5895.882082358329, 5938.584299099108, 5482.616216864861, 5621.747021384048, 5644.520215781622, 5710.543156547466, 5725.59920805548, 5721.485066344049, 5736.741846616912, 5740.0, 5744.684042377709, 5752.165935939265, 5660.547156227574, 5669.6314739541795, 5670.688112153789, 5699.2590963174525, 5707.3721890592005, 5425.647332923348, 5573.386927437979, 5644.125160600113, 5655.123455864347, 5682.062459694104, 4149.751014939114, 4251.766152861561, 4300.182965236595, 4308.482982042175, 4344.109457561192, 3907.27715372657, 3913.0413048802657, 3924.372100463912, 3944.1322908959983, 3980.641742243212, 5217.6347655664495, 5372.0, 5459.2902922619805, 5490.396056433789, 5558.471945165203, 5700.743466544015, 5714.514266287412, 5736.541076713853, 5750.0512415450985, 5787.855303617359, 5395.3525576931015, 5436.374816896028, 5443.156310771837, 5443.755031023614, 5449.536789372868, 4843.878903027382, 4932.53140951609, 4936.456989731127, 4995.500449954975, 5007.198848184273, 5924.496417804448, 5939.613925094942, 5945.227120474311, 5954.166416701665, 5966.8961242170335, 5718.399568045295, 5734.971325143348, 5739.569532285179, 5745.339285982165, 5746.051901436384, 5849.883002340014, 5850.531957443309, 5958.255218097738, 5966.343702192668, 6020.307664618625, 5652.7173641318595, 5653.745581448762, 5656.321241451053, 5665.093585026376, 5668.291463567054, 5745.97127014379, 5750.741216645178, 5761.913571296518, 5763.538916886723, 5764.164196191613, 5453.809116680897, 5481.808136715196, 5536.058869992192, 5541.861453463695, 5553.361363443094, 5558.194061861089, 5571.331440227036, 5572.164175373727, 5572.275604171432, 5587.608867379245, 5344.091504444332, 5376.542993845411, 5468.972655136698, 5494.835154945358, 5511.669299842022, 5423.647462914898, 5503.972480137573, 5542.8337149885565, 5544.140658197985, 5597.720113994203, 5494.0, 5531.585131115263, 5537.446255374592, 5540.196671482532, 5582.665040097607], "value": 5274.539934767773, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.5832896137184, 634.7905191286874, 646.5764923974797, 655.0240142188142, 666.490135046689, 35578.644213557855, 36560.451593226055, 36565.999999999935, 36626.45060324094, 36830.0, 41223.38164927528, 42148.36777448333, 42223.57776422235, 42424.36363454551, 42436.787816060874, 8563.186497282748, 8696.782580435509, 8724.258438032775, 8744.256738177231, 8761.780955476132, 8587.484750914966, 8673.69642062528, 8680.522571258578, 8708.346873984476, 8733.781655458633, 8653.350998675125, 8686.174813392718, 8727.258183054448, 8735.95632021839, 8742.213200811926, 8617.61220745065, 8689.739307820775, 8714.825703485958, 8722.694705685333, 8727.214550690436, 8576.39965202436, 8696.913030869737, 8711.259542938858, 8713.607887645072, 8722.171393717586, 28979.420411591862, 38728.61271387278, 39128.41307380363, 39248.607513924784, 39255.0, 2909.854507274628, 2925.7366836984775, 3064.0654600346884, 3123.500239961595, 3131.389379071082, 28525.0, 28701.856490717622, 28744.71255287441, 28907.988220412393, 30124.698753012628, 3847.241867043853, 3848.494219278406, 3911.159100793315, 3953.6639385652256, 4032.4152997815445, 203350.0, 204437.0, 206301.9684901581, 206570.0, 207390.0, 32967.0, 51545.7422712884, 52029.47970520322, 52146.47853521416, 52183.478165217864, 34442.0, 34476.310473790385, 34554.65445345514, 34686.30627387438, 34773.13067173341, 13919.164850109026, 14017.369218385196, 14145.575632731034, 14162.079464834753, 14173.078749881224, 11845.052395808314, 11845.822312665317, 11853.46659400329, 11910.225835320676, 11977.64067077989, 8390.03514595817, 8500.064992850781, 8583.141685831368, 8642.049374568793, 8658.653653853902, 3318.386098571772, 3325.2376240592525, 3333.516640087174, 3374.207061340583, 3377.9359501756867, 1104.8066588347008, 1129.1932907348178, 1129.6046383765781, 1158.9652310430702, 1170.4323403149465, 30801.69198308033, 31212.531812022837, 31657.891973780806, 31770.364592708018, 31778.364432711216, 1104.9778954467085, 1142.2232881640398, 1145.959891403797, 1186.323795436593, 1209.866914639389, 17013.744793828104, 17017.48947531576, 17087.572810679834, 17268.13659317029, 17417.129143542774, 457932.0, 461046.947652616, 462923.0, 464473.0, 466046.0, 56088.0, 56455.43544564502, 56506.7174664124, 57196.71401643049, 57241.42758572444, 1364.6588352911772, 1366.125679565079, 1394.9372278247504, 1400.5728252882968, 1400.7688731359415, 30469.390612188075, 30951.535726963662, 31326.686733133287, 31690.207744806565, 32534.349313013136, 46414.30378544392, 47730.28404573865, 48960.510394895595, 49049.0, 49210.0, 424315.0, 428310.0, 429098.0, 429645.0, 429790.0, 41665.1666966665, 42243.57756422397, 42565.0, 42610.57389426066, 42652.0, 42092.36861447142, 43187.78595583872, 46409.53590464052, 46473.0, 48159.75920120377, 38595.0, 39555.40666889941, 39588.60411395964, 40607.59392406156, 40853.59146408498, 37296.25407491781, 38171.0, 38331.0, 38528.42207366836, 38694.22611547809, 38907.22185556329, 39362.0, 39427.80286098551, 39880.800595996836, 40457.59542404538, 33999.0, 34250.65749342475, 35445.645543545266, 36061.81969090138, 36220.456693150154, 26656.466870662865, 26999.0, 27029.51337676368, 27093.458130837666, 27357.316067098483], "value": 18100.409136964478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.1996766531606, 397.9940300895485, 401.64053172410695, 402.28995822373514, 402.72010952388086, 17634.294628214873, 18057.729134062967, 18510.537236569093, 18537.443876683705, 18858.528536786587, 18173.545661358472, 18946.715799263024, 19050.809491905078, 19199.13603887825, 19329.61340773184, 5419.268398766156, 5450.182472629098, 5507.091329930557, 5510.724463776795, 5649.661020338773, 5478.205660179272, 5514.95215908978, 5537.833864984057, 5540.944590554103, 5547.306586676666, 5421.918671219935, 5450.29146210992, 5505.779768809243, 5512.4211957744465, 5555.916661250085, 5544.0575102232715, 5551.1673249012565, 5552.500274975251, 5576.163575463693, 5576.972115139399, 4743.525647435264, 4990.800367985276, 5005.624578156653, 5024.824131155428, 5031.949680503185, 22165.556688866294, 22427.55144897109, 22427.663585046237, 22654.66018009731, 22808.88595557028, 2247.381969958258, 2347.835651504395, 2375.5011447596025, 2553.3106061363515, 2999.4451026560155, 13727.313634318343, 14077.36651850659, 14177.291135443289, 14250.073745206528, 14271.215083170422, 1885.4343696890878, 1996.9001549922446, 2054.311805545144, 2062.1957436599737, 2063.030375723408, 78527.60736196283, 80109.59945200237, 80970.59514702507, 81208.18791812066, 81447.18552814514, 9948.651797187063, 10057.446840423701, 10187.185025197967, 10187.54156062979, 10407.271490995709, 13899.818515426303, 13970.0, 13982.930085349508, 14000.719985600232, 14002.089864158797, 7627.584042678373, 7868.370530357558, 7896.512598531444, 7949.7217597383815, 7964.840703185904, 7585.544867307869, 7652.693892244248, 7692.384609231248, 7720.189380115007, 7763.573003484863, 6265.686715664198, 6430.967845160744, 6467.32093130224, 6470.547061705635, 6503.7073331700185, 1830.7207526629431, 1835.3759721694687, 1855.2300795170124, 1872.1388161445616, 1898.8006259342847, 928.3872644055026, 1057.0750593230923, 1096.4956120184804, 1111.9944400277948, 1168.1355796710372, 17503.0, 18028.819711802975, 18347.633047339245, 19045.0, 19443.4166974991, 1027.7173777211326, 1033.705393962717, 1101.6254473479055, 1101.884302148279, 1121.5494145292398, 10097.394156350643, 10602.310849794738, 10841.728956776144, 10899.182561307774, 10901.20780427387, 475242.0, 477558.0, 478816.0, 488931.0, 500896.0, 96975.51512242535, 97659.0, 97977.51011244899, 98085.0, 98393.50803245937, 1054.2514814481651, 1069.4706120470416, 1079.4494807648157, 1088.1621151713296, 1091.8089334366455, 16898.493045208663, 17011.48965531036, 17048.744268836224, 17105.657886842444, 17111.82888171152, 40702.185956281304, 40999.38500922429, 41018.0, 41183.382249266884, 41460.37809432801, 57767.422325776206, 59196.40803591909, 59336.703316483145, 59344.406555933885, 60627.09059364201, 8124.146964568871, 8334.6666133354, 8481.321494280319, 8526.062133165471, 8624.913750862412, 9614.95192524033, 11964.940175299067, 12791.488340466278, 12945.158564693265, 13188.736225275248, 10549.841752373874, 12089.335086570323, 12131.393430328624, 12194.817077743663, 12287.324197169242, 10630.787384252117, 11641.0, 11724.70688232801, 11770.117241206772, 11987.64037078889, 11881.702957426134, 12148.817767733668, 12205.20666156697, 12298.139130260795, 12323.753524929272, 7865.488743231672, 8241.876371854547, 8328.875066874123, 8373.33013358942, 8561.657533698582, 8554.358423118416, 11819.763604728028, 11922.284662920252, 12140.575079872162, 12282.385880706108], "value": 9268.624210454043, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.5303902751118, 1501.9098854068754, 1613.419169099124, 1714.237164461815, 1717.6908156531827, 7377.594232317234, 7960.203979602037, 7992.92007079929, 8252.00975882894, 8275.337972962163, 7960.681572737083, 7968.083670377909, 8012.719554815582, 8041.91958080419, 8064.71773487928, 2214.4795972946386, 2272.9090836366527, 2274.7042884425, 2280.4754906371545, 2284.9543009139807, 2203.537257175995, 2206.106526856626, 2223.7665045170265, 2226.421130506072, 2241.674957131215, 2190.233418303589, 2202.7576966533748, 2217.3126330837413, 2271.6706077618737, 2298.0233400804673, 2160.168335190955, 2164.8701077935375, 2165.1988764157204, 2176.597329494041, 2177.1835561664375, 2118.798714122156, 2126.3514628038442, 2127.0747224957195, 2129.744430668314, 2138.027197625077, 8143.470674406145, 8227.588620568948, 8231.547264900428, 8233.259006689426, 8240.13478584746, 4833.32333473314, 5004.474530174352, 5007.349044624176, 5037.0, 5041.647084704072, 2908.200244932639, 2935.0, 2968.0, 2984.3136078701805, 2988.4023195360796, 963.3352986439335, 972.3922548407245, 976.6581696406272, 987.2694206287296, 996.1482932093029, 11047.558097676083, 11157.944210278896, 11183.32900026001, 11185.49665265065, 11206.607768728138, 4408.58118478744, 4413.3821265022925, 4468.932966005513, 4493.326001099861, 4512.120136573402, 9441.291903107294, 9442.527873606292, 9502.524873756285, 9525.476098814494, 9546.284028697875, 4830.058138662927, 4862.927056094161, 4872.4883887192045, 4877.341558889504, 4982.576480999156, 4120.484939382577, 4505.414296141546, 4514.977425112854, 4584.518625544337, 4642.976785116053, 3753.8310776015146, 3773.905652358713, 3830.291396091732, 3847.0, 3883.359245724424, 1172.783035138502, 1264.3551788587702, 1265.943032563537, 1267.1383459247616, 1274.4965738533228, 934.444005816538, 936.2322895225985, 949.0604301741226, 956.2015716876347, 958.4105774948496, 5243.318368612056, 5320.787168513216, 5329.813456529003, 5401.243825864382, 5541.972290138524, 408.2040021957195, 411.1222539877383, 411.9824034634448, 412.07900342733967, 981.283662926068, 3954.307996100671, 4142.357934520094, 4153.979230103831, 4160.91678166441, 4222.176675548239, 10378.636747713794, 10727.892721072845, 10825.242233043611, 10846.837297440545, 10862.348259104321, 10191.082802547806, 10384.636537721295, 10494.580216791395, 10499.265051446326, 10546.736331591772, 7989.320907722792, 8039.075506316848, 8049.798755031171, 8089.069756978023, 8214.342852571779, 5822.94177058224, 5901.29184497863, 5980.192673988956, 5989.940100598938, 6093.725782339717, 9622.0, 9687.128158465772, 9872.829481574016, 9926.602935882773, 9937.10566049059, 9976.2517811163, 10070.8489372658, 10197.23520735933, 10295.227857910537, 10303.948480257552, 6566.868662626816, 6960.686769095301, 7168.139823221247, 7214.855702886018, 7353.852922941618, 7801.2198780121535, 7839.0, 7842.725504607311, 7869.291763741291, 7890.881636775338, 6992.9860170274005, 7133.2153463117975, 7139.535930164523, 7232.566046037255, 7250.854982900207, 7082.5396349237135, 7092.290770922867, 7113.0, 7172.677229524579, 7197.784066478014, 6708.161479815023, 7054.153501579844, 7056.188538318159, 7058.082449281561, 7061.717531298896, 4903.60771138301, 5030.446650868328, 5045.066662667418, 5080.974595127001, 5127.256547800623, 5116.258142569232, 5154.9732529675575, 5207.4271830099415, 5311.2829767982375, 5335.039692855324], "value": 4348.321407706581, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.3114829337404, 313.850920812614, 314.1674562409614, 314.3383178409447, 316.2631069607814, 5351.093701597836, 5480.561555075595, 5506.146547285167, 5557.194206840006, 5602.478884501975, 5522.502974732273, 5522.861928451791, 5536.307961504812, 5541.473560011803, 5547.33431988161, 4210.221109094812, 4246.893827654302, 4258.680598955075, 4273.807678654468, 4290.120525292323, 4205.747655140686, 4292.742435453867, 4303.526612072686, 4303.655707543405, 4318.956810431887, 4168.145530166309, 4225.154969006211, 4226.535081141072, 4237.809298581571, 4244.27847265964, 4187.51843537994, 4222.619964203221, 4235.216484950279, 4238.364245363189, 4239.957600423987, 3623.927521449556, 3685.4471829225563, 3687.1888184599347, 3690.0959264979983, 3713.0, 5296.655717378397, 5356.785728570852, 5362.115250983583, 5363.812266570651, 5370.5435038021815, 4807.879803004953, 4858.927116093261, 4874.780634871439, 4883.438404583483, 4885.853424397274, 5558.86102847428, 5663.716814159276, 5716.0, 5781.13283007548, 5782.45066718661, 4018.5378681451716, 4037.1723796621623, 4042.272390969624, 4051.675865930748, 4056.1482088761395, 6053.213082299317, 6059.242594675666, 6074.787382441637, 6083.8174854754425, 6108.297545782203, 4016.674497415846, 4038.7172897896867, 4120.608542188487, 4126.855560055384, 4149.564295748964, 4160.084781348099, 4177.498700156001, 4177.791110444466, 4181.623653871166, 4204.66362690984, 4831.767899185686, 4832.685875418087, 4835.6131509479155, 4856.6886940526565, 4858.562729354305, 5652.0, 5863.651360187181, 5875.500582450454, 5880.147378630075, 5898.4101589840675, 1483.6810085831382, 1489.9346966918488, 1498.2883130513137, 1500.9699806003819, 1504.9774253386208, 935.1583574782615, 965.6716716316486, 966.7873067925045, 981.548487695668, 985.9063388978036, 5991.824333103462, 5992.280926288786, 6002.789902353396, 6017.2779266488305, 6033.909491357633, 6280.623162610258, 6333.493320534346, 6341.524385671093, 6343.794679010974, 6368.331325210879, 5399.352077750695, 5737.799177028784, 5747.453991870766, 5805.477507024388, 5937.52499800015, 3425.246445781924, 3445.4323282906216, 3446.1556918555116, 3448.413769659164, 3454.8790792322147, 6467.4179323860135, 6626.834329141713, 6646.567973081735, 6709.194896612437, 6728.0, 6511.511636627272, 6544.280129185786, 6551.443127334134, 6555.541112122201, 6577.736890524326, 6445.132835768931, 6635.701393437307, 6686.364795344434, 6705.932940670531, 6722.731090756315, 6375.713092910737, 6383.39357761012, 6401.7119229633845, 6403.0, 6449.645269510222, 6337.144485494584, 6355.173827402408, 6413.775517856852, 6414.935850641434, 6425.710843011982, 6027.126066720389, 6318.968405158129, 6358.554901156875, 6370.362963703593, 6386.137871387304, 3863.652271295597, 3940.802959851939, 4057.289974254553, 4080.285949958805, 4086.81609327575, 6007.459328660441, 6045.0, 6060.606060606046, 6071.119687645179, 6082.90875636857, 5724.942750572441, 5775.249217601685, 5855.121731740273, 5860.062390017577, 5890.3226128994, 5814.680192589448, 5819.127130930225, 5831.250624812624, 5835.56233282514, 5840.853978650568, 5683.9715801420725, 5728.627639203439, 5755.7122143893475, 5767.538596912321, 5806.332271788799, 5687.516561092353, 5749.8562535936935, 5796.652200867793, 5811.738471768696, 5844.1525978732, 5681.9431805681415, 5722.141678748221, 5728.338781753245, 5740.13897915316, 5767.452092051249], "value": 4467.821212175743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.5948950884715, 686.2931180883688, 692.6779047742799, 714.4748609771817, 728.1117037214597, 12273.263604183756, 12578.622641320764, 13320.067595268323, 13525.661858453544, 13564.457421703144, 13020.60938171854, 13155.210687358765, 13192.472301107968, 13194.868051319483, 13294.800577991338, 777.953322800631, 790.4071946040469, 790.9050913890312, 793.0404210904812, 794.4835856693138, 662.7978466567695, 778.4550814429894, 780.9765707028798, 793.896793416855, 799.1648727080216, 811.6996711216858, 814.9796255093611, 819.2585709932491, 819.573821612761, 821.9465734727254, 804.0913767442811, 812.5003123079323, 812.5165526511776, 818.4639061414783, 818.9140140285274, 591.8461200087966, 592.1946153231602, 593.9287285525764, 596.3916804859019, 601.3114983344091, 12684.556040538537, 12720.363981800872, 12729.618111456672, 12747.553835615709, 12842.871571284355, 12541.811872821914, 12776.680582985407, 12792.360381980863, 13118.212907225598, 13297.933510332483, 9944.70165895017, 10191.133753630951, 10215.948920255425, 10282.845757313646, 10305.0, 3719.0, 3766.5291838520184, 3822.1591249924973, 3847.0, 3864.652181303696, 55720.721396393164, 55893.44106558923, 56094.0, 56484.0, 56678.71660641712, 9540.0, 9717.61129554824, 9767.0, 9791.461469619097, 9824.263180261367, 17930.19314130867, 18030.729539056923, 18040.819591803913, 18067.45797626073, 18080.095995200187, 7771.572563509061, 7794.493357931717, 7795.376369890509, 8014.519128852287, 8075.959620201861, 4482.731036137842, 4507.752073635916, 4540.931886021713, 4557.156925968707, 4592.931106033412, 2928.1654728402727, 2970.7177818107243, 3000.204945689394, 3005.173577266269, 3015.050259168355, 565.6860442454478, 591.9970400148057, 592.7006861534984, 597.4055814464635, 598.9401059893976, 656.7274581048811, 672.9831754206086, 688.4561196654687, 704.8097013806243, 755.3390783064818, 9095.909040909639, 9106.635734570544, 9141.588628511732, 9188.219001384823, 9478.90521094794, 678.9762358317436, 690.5925503952692, 701.919279282889, 759.472166844038, 761.6420282467232, 4201.432806571135, 4264.0385422705285, 4288.228118938621, 4328.004558951458, 4366.345048242789, 67933.0, 70706.0, 70798.64600676963, 71750.28249717435, 71995.0, 59464.70267648634, 60229.0, 60369.698151508965, 60933.695331523944, 61081.043367321014, 51709.0, 54656.90686186254, 54759.178612320844, 55053.174202386996, 55857.720711396185, 9405.247580193705, 9412.717618471457, 9533.332666713264, 9607.759806004626, 9609.231261498924, 34769.47845782366, 35202.29595408129, 35866.46200306945, 36143.81928090343, 36299.63700362963, 44283.77858110689, 47713.28430073482, 48596.27105593348, 48837.75581122214, 49216.0, 11552.768944620891, 11616.767664646828, 11796.646100616996, 11806.940965295118, 12040.277583345027, 12851.357432128543, 12965.611031669065, 13008.479660813462, 13184.73630527365, 13281.0, 11491.597794077166, 11796.882031179579, 11867.347295898808, 12280.263184208976, 12604.11771176009, 11945.641630751092, 12204.938975305422, 12243.938780306042, 12270.509179632714, 12275.447604857623, 10154.289199755945, 11552.6534203974, 11793.52825886955, 11821.763564728486, 12553.49786008586, 10090.69727908164, 10514.631987880388, 10613.628523001658, 10829.458527073457, 10851.0, 10293.0, 10684.46577671129, 10701.732456688645, 10918.727031824268, 10935.671929842118], "value": 6555.339646765533, "unit": "score"}], "name": "dromaeo_css", "value": 6950.089691088803, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 112.0, 110.0, 111.0, 123.0, 110.0, 109.0, 110.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 161.0, 191.0, 127.0, 154.0, 162.0, 131.0, 186.0, 132.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 163.0, 163.0, 165.0, 166.0, 175.0, 162.0, 164.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 154.0, 77.0, 76.0, 85.0, 77.0, 167.0, 77.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 157.0, 93.0, 93.0, 93.0, 149.0, 93.0, 93.0, 143.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 122.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 100.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 63.0, 59.0, 60.0, 61.0, 59.0, 82.0, 57.0, 55.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 62.0, 64.0, 60.0, 61.0, 66.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 84.0, 76.0, 77.0, 78.0, 81.0, 77.0, 86.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 124.0, 134.0, 128.0, 124.0, 124.0, 131.0, 132.0, 207.0, 123.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 171.0, 168.0, 165.0, 167.0, 168.0, 168.0, 169.0, 164.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 68.0, 69.0, 66.0, 73.0, 68.0, 67.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1566.6999999999998, "alertThreshold": 2.0}]} 07:39:57 INFO - Return code: 0 07:39:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:39:57 ERROR - # TBPL SUCCESS # 07:39:57 INFO - Running post-action listener: _resource_record_post_action 07:39:57 INFO - Running post-run listener: _resource_record_post_run 07:39:58 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9949184; Write bytes: 415944704; Read time: 3144; Write time: 288876 07:39:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1224704; Read time: 0; Write time: 88 07:39:58 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 9949184; Write bytes: 352681984; Read time: 3144; Write time: 252332 07:39:58 INFO - Running post-run listener: _upload_blobber_files 07:39:58 INFO - Blob upload gear active. 07:39:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:58 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 07:39:58 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'] 07:39:58 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 07:39:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:59 INFO - (blobuploader) - INFO - Done attempting. 07:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:00 INFO - (blobuploader) - INFO - Done attempting. 07:40:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:40:00 INFO - Return code: 0 07:40:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:40:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:40:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6637ccd7576b5eada5438bea3b121be57a14b68ad8020b4a61613bb0a999bff848c82666d8965a4f7609a506ea52931c99372cd5f9f60a2d4653b19eb9d216f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03417f2e347e706c72c358e01ce1fddd65f1d9ca7bc5c39c35860b56d13d5b84048240ddda8ed506ed6a53abd4638895c913927fe0fd1adae452dbd289905dc3"} 07:40:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:40:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:40:00 INFO - Contents: 07:40:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6637ccd7576b5eada5438bea3b121be57a14b68ad8020b4a61613bb0a999bff848c82666d8965a4f7609a506ea52931c99372cd5f9f60a2d4653b19eb9d216f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03417f2e347e706c72c358e01ce1fddd65f1d9ca7bc5c39c35860b56d13d5b84048240ddda8ed506ed6a53abd4638895c913927fe0fd1adae452dbd289905dc3"} 07:40:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:40:00 INFO - Copying logs to upload dir... 07:40:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:40:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.796657 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-25 07:40:00.101850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:40:00.105266) ========= 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=82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026 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/c6637ccd7576b5eada5438bea3b121be57a14b68ad8020b4a61613bb0a999bff848c82666d8965a4f7609a506ea52931c99372cd5f9f60a2d4653b19eb9d216f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03417f2e347e706c72c358e01ce1fddd65f1d9ca7bc5c39c35860b56d13d5b84048240ddda8ed506ed6a53abd4638895c913927fe0fd1adae452dbd289905dc3"} build_url:https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/VvOCAQ17Qy-k1eLgfXfboQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6637ccd7576b5eada5438bea3b121be57a14b68ad8020b4a61613bb0a999bff848c82666d8965a4f7609a506ea52931c99372cd5f9f60a2d4653b19eb9d216f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03417f2e347e706c72c358e01ce1fddd65f1d9ca7bc5c39c35860b56d13d5b84048240ddda8ed506ed6a53abd4638895c913927fe0fd1adae452dbd289905dc3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:40:00.130598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:40:00.130951) ========= 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=82e07478c745e68b1fe4678a000001bc-1461593964.853598-1508556026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:40:00.217777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:40:00.218123) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:40:00.218441) ========= ========= Total master_lag: 0.18 =========