builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1463567414.99 results: success (0) buildid: 20160518004015 builduid: 7b8ca2ff7e89436d9ce06cc5148fed1c revision: b4e6080db0238862dfb893ea6ab564fcd4375da1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:14.993493) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:14.993911) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:14.994193) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:15.045742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:15.046003) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 03:30:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-05-18 03:30:15 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.343771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:15.414598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:15.414897) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:15.464746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:15.465071) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b4e6080db0238862dfb893ea6ab564fcd4375da1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b4e6080db0238862dfb893ea6ab564fcd4375da1 --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=14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 03:30:15,520 truncating revision to first 12 chars 2016-05-18 03:30:15,520 Setting DEBUG logging. 2016-05-18 03:30:15,520 attempt 1/10 2016-05-18 03:30:15,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b4e6080db023?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 03:30:15,788 unpacking tar archive at: mozilla-aurora-b4e6080db023/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:16.031856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:16.032146) ========= script_repo_revision: b4e6080db0238862dfb893ea6ab564fcd4375da1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:16.032525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:16.032793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 03:30:16.043995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-18 03:30:16.044286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:16 INFO - MultiFileLogger online at 20160518 03:30:16 in /builds/slave/test 03:30:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:30:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:16 INFO - {'append_to_log': False, 03:30:16 INFO - 'base_work_dir': '/builds/slave/test', 03:30:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:16 INFO - 'branch': 'Mozilla-Aurora', 03:30:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:16 INFO - 'config_files': ('talos/linux_config.py',), 03:30:16 INFO - 'default_actions': ('clobber', 03:30:16 INFO - 'read-buildbot-config', 03:30:16 INFO - 'download-and-extract', 03:30:16 INFO - 'populate-webroot', 03:30:16 INFO - 'create-virtualenv', 03:30:16 INFO - 'install', 03:30:16 INFO - 'run-tests'), 03:30:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:16 INFO - 'download_minidump_stackwalk': True, 03:30:16 INFO - 'download_symbols': 'ondemand', 03:30:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:16 INFO - 'installer_path': 'installer.exe', 03:30:16 INFO - 'log_level': 'info', 03:30:16 INFO - 'log_name': 'talos', 03:30:16 INFO - 'log_to_console': True, 03:30:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:16 INFO - 'opt_config_files': (), 03:30:16 INFO - 'pip_index': False, 03:30:16 INFO - 'sps_profile': False, 03:30:16 INFO - 'sps_profile_interval': 0, 03:30:16 INFO - 'suite': 'dromaeojs', 03:30:16 INFO - 'system_bits': '32', 03:30:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:16 INFO - 'title': 'talos-linux64-ix-036', 03:30:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:16 INFO - 'use_talos_json': True, 03:30:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:16 INFO - 'work_dir': 'build'} 03:30:16 INFO - ##### 03:30:16 INFO - ##### Running clobber step. 03:30:16 INFO - ##### 03:30:16 INFO - Running pre-action listener: _resource_record_pre_action 03:30:16 INFO - Running main action method: clobber 03:30:16 INFO - rmtree: /builds/slave/test/build 03:30:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:17 INFO - Running post-action listener: _resource_record_post_action 03:30:17 INFO - ##### 03:30:17 INFO - ##### Running read-buildbot-config step. 03:30:17 INFO - ##### 03:30:17 INFO - Running pre-action listener: _resource_record_pre_action 03:30:17 INFO - Running main action method: read_buildbot_config 03:30:17 INFO - Using buildbot properties: 03:30:17 INFO - { 03:30:17 INFO - "project": "", 03:30:17 INFO - "product": "firefox", 03:30:17 INFO - "script_repo_revision": "production", 03:30:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:30:17 INFO - "repository": "", 03:30:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:30:17 INFO - "buildid": "20160518004015", 03:30:17 INFO - "stage_platform": "linux64-pgo", 03:30:17 INFO - "basedir": "/builds/slave/test", 03:30:17 INFO - "nightly_build": "True", 03:30:17 INFO - "buildnumber": 238, 03:30:17 INFO - "slavename": "talos-linux64-ix-036", 03:30:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:17 INFO - "platform": "ubuntu64_hw", 03:30:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:17 INFO - "branch": "mozilla-aurora", 03:30:17 INFO - "repo_path": "releases/mozilla-aurora", 03:30:17 INFO - "revision": "b4e6080db0238862dfb893ea6ab564fcd4375da1", 03:30:17 INFO - "pgo_build": "True", 03:30:17 INFO - "builduid": "7b8ca2ff7e89436d9ce06cc5148fed1c", 03:30:17 INFO - "slavebuilddir": "test" 03:30:17 INFO - } 03:30:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:30:17 INFO - Running post-action listener: _resource_record_post_action 03:30:17 INFO - ##### 03:30:17 INFO - ##### Running download-and-extract step. 03:30:17 INFO - ##### 03:30:17 INFO - Running pre-action listener: _resource_record_pre_action 03:30:17 INFO - Running main action method: download_and_extract 03:30:17 INFO - mkdir: /builds/slave/test/build/tests 03:30:17 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')]} 03:30:17 INFO - https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:30:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:30:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:30:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:30:24 INFO - Downloaded 1361 bytes. 03:30:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:30:24 INFO - Using the following test package requirements: 03:30:24 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:24 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:24 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:24 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'jsshell-linux-x86_64.zip'], 03:30:24 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:24 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:24 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:24 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:24 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:24 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:24 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:24 INFO - https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:29 INFO - Downloaded 23813542 bytes. 03:30:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:30 INFO - Return code: 0 03:30:30 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:30 INFO - https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:34 INFO - Downloaded 23813542 bytes. 03:30:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:36 INFO - Return code: 0 03:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:36 INFO - https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:30:38 INFO - Downloaded 10840145 bytes. 03:30:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:30:38 INFO - Return code: 0 03:30:38 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')]} 03:30:38 INFO - https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:30:39 INFO - Downloaded 62723536 bytes. 03:30:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:39 INFO - mkdir: /builds/slave/test/properties 03:30:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:39 INFO - Contents: 03:30:39 INFO - build_url:https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:40 INFO - Running post-action listener: _resource_record_post_action 03:30:40 INFO - Running post-action listener: set_extra_try_arguments 03:30:40 INFO - ##### 03:30:40 INFO - ##### Running populate-webroot step. 03:30:40 INFO - ##### 03:30:40 INFO - Running pre-action listener: _resource_record_pre_action 03:30:40 INFO - Running main action method: populate_webroot 03:30:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:40 INFO - '--tppagecycles', 03:30:40 INFO - '7'], 03:30:40 INFO - 'tests': ['tsvgm']}}, 03:30:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['damp', 'tps']}, 03:30:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'tests': ['damp', 'tps']}, 03:30:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['dromaeo_dom']}, 03:30:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['a11yr', 03:30:40 INFO - 'ts_paint', 03:30:40 INFO - 'tpaint', 03:30:40 INFO - 'sessionrestore', 03:30:40 INFO - 'sessionrestore_no_auto_restore', 03:30:40 INFO - 'tabpaint']}, 03:30:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:40 INFO - 'ts_paint', 03:30:40 INFO - 'tpaint', 03:30:40 INFO - 'sessionrestore', 03:30:40 INFO - 'sessionrestore_no_auto_restore', 03:30:40 INFO - 'tabpaint']}, 03:30:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:40 INFO - 'ts_paint', 03:30:40 INFO - 'tpaint', 03:30:40 INFO - 'sessionrestore', 03:30:40 INFO - 'sessionrestore_no_auto_restore', 03:30:40 INFO - 'tabpaint']}, 03:30:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:40 INFO - 'ts_paint', 03:30:40 INFO - 'tpaint', 03:30:40 INFO - 'sessionrestore', 03:30:40 INFO - 'sessionrestore_no_auto_restore', 03:30:40 INFO - 'tabpaint']}, 03:30:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['a11yr', 03:30:40 INFO - 'ts_paint', 03:30:40 INFO - 'tpaint', 03:30:40 INFO - 'sessionrestore', 03:30:40 INFO - 'sessionrestore_no_auto_restore', 03:30:40 INFO - 'tabpaint']}, 03:30:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['a11yr', 03:30:40 INFO - 'ts_paint', 03:30:40 INFO - 'tpaint', 03:30:40 INFO - 'sessionrestore', 03:30:40 INFO - 'sessionrestore_no_auto_restore', 03:30:40 INFO - 'tabpaint']}, 03:30:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['tsvgx', 03:30:40 INFO - 'tsvgr_opacity', 03:30:40 INFO - 'tart', 03:30:40 INFO - 'tscrollx', 03:30:40 INFO - 'cart']}, 03:30:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:40 INFO - 'tsvgr_opacity', 03:30:40 INFO - 'tart', 03:30:40 INFO - 'tscrollx', 03:30:40 INFO - 'cart']}, 03:30:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'talos_options': ['--disable-e10s'], 03:30:40 INFO - 'tests': ['tp5o']}, 03:30:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'tests': ['tp5o']}, 03:30:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'talos_options': ['--disable-e10s', 03:30:40 INFO - '--xperf_path', 03:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:40 INFO - 'tests': ['tp5n']}, 03:30:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:40 INFO - 'talos_options': ['--xperf_path', 03:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:40 INFO - 'tests': ['tp5n']}}, 03:30:40 INFO - 'talos.zip': {'path': '', 03:30:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:40 INFO - Running post-action listener: _resource_record_post_action 03:30:40 INFO - ##### 03:30:40 INFO - ##### Running create-virtualenv step. 03:30:40 INFO - ##### 03:30:40 INFO - Running pre-action listener: _resource_record_pre_action 03:30:40 INFO - Running main action method: create_virtualenv 03:30:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:30:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:40 INFO - Using real prefix '/usr' 03:30:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:43 INFO - Installing pip.................done. 03:30:43 INFO - Return code: 0 03:30:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:30:43 INFO - Using env: {'DISPLAY': ':0', 03:30:43 INFO - 'HOME': '/home/cltbld', 03:30:43 INFO - 'LANG': 'en_US.UTF-8', 03:30:43 INFO - 'LANGUAGE': 'en_US:en', 03:30:43 INFO - 'LOGNAME': 'cltbld', 03:30:43 INFO - 'MAIL': '/var/mail/cltbld', 03:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:43 INFO - 'MOZ_NO_REMOTE': '1', 03:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:43 INFO - 'NO_EM_RESTART': '1', 03:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:43 INFO - 'PWD': '/builds/slave/test', 03:30:43 INFO - 'SHELL': '/bin/bash', 03:30:43 INFO - 'SHLVL': '1', 03:30:43 INFO - 'TERM': 'linux', 03:30:43 INFO - 'TMOUT': '86400', 03:30:43 INFO - 'USER': 'cltbld', 03:30:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:43 INFO - '_': '/tools/buildbot/bin/python'} 03:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:44 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 03:30:44 INFO - Cleaning up... 03:30:44 INFO - Return code: 0 03:30:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:30:44 INFO - Using env: {'DISPLAY': ':0', 03:30:44 INFO - 'HOME': '/home/cltbld', 03:30:44 INFO - 'LANG': 'en_US.UTF-8', 03:30:44 INFO - 'LANGUAGE': 'en_US:en', 03:30:44 INFO - 'LOGNAME': 'cltbld', 03:30:44 INFO - 'MAIL': '/var/mail/cltbld', 03:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:44 INFO - 'MOZ_NO_REMOTE': '1', 03:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:44 INFO - 'NO_EM_RESTART': '1', 03:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:44 INFO - 'PWD': '/builds/slave/test', 03:30:44 INFO - 'SHELL': '/bin/bash', 03:30:44 INFO - 'SHLVL': '1', 03:30:44 INFO - 'TERM': 'linux', 03:30:44 INFO - 'TMOUT': '86400', 03:30:44 INFO - 'USER': 'cltbld', 03:30:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:44 INFO - '_': '/tools/buildbot/bin/python'} 03:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:44 INFO - Downloading/unpacking psutil>=0.7.1 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:46 INFO - Installing collected packages: psutil 03:30:46 INFO - Running setup.py install for psutil 03:30:46 INFO - building 'psutil._psutil_linux' extension 03:30:46 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 03:30:48 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 03:30:48 INFO - building 'psutil._psutil_posix' extension 03:30:48 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 03:30:49 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 03:30:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:49 INFO - Successfully installed psutil 03:30:49 INFO - Cleaning up... 03:30:49 INFO - Return code: 0 03:30:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:30: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:30: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 mozsystemmonitor==0.0.0 03:30:49 INFO - Using env: {'DISPLAY': ':0', 03:30:49 INFO - 'HOME': '/home/cltbld', 03:30:49 INFO - 'LANG': 'en_US.UTF-8', 03:30:49 INFO - 'LANGUAGE': 'en_US:en', 03:30:49 INFO - 'LOGNAME': 'cltbld', 03:30:49 INFO - 'MAIL': '/var/mail/cltbld', 03:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:49 INFO - 'MOZ_NO_REMOTE': '1', 03:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:49 INFO - 'NO_EM_RESTART': '1', 03:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:49 INFO - 'PWD': '/builds/slave/test', 03:30:49 INFO - 'SHELL': '/bin/bash', 03:30:49 INFO - 'SHLVL': '1', 03:30:49 INFO - 'TERM': 'linux', 03:30:49 INFO - 'TMOUT': '86400', 03:30:49 INFO - 'USER': 'cltbld', 03:30:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:49 INFO - '_': '/tools/buildbot/bin/python'} 03:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:30:51 INFO - Installing collected packages: mozsystemmonitor 03:30:51 INFO - Running setup.py install for mozsystemmonitor 03:30:51 INFO - Successfully installed mozsystemmonitor 03:30:51 INFO - Cleaning up... 03:30:51 INFO - Return code: 0 03:30:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:51 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 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:30:51 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 03:30:51 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 03:30:51 INFO - Using env: {'DISPLAY': ':0', 03:30:51 INFO - 'HOME': '/home/cltbld', 03:30:51 INFO - 'LANG': 'en_US.UTF-8', 03:30:51 INFO - 'LANGUAGE': 'en_US:en', 03:30:51 INFO - 'LOGNAME': 'cltbld', 03:30:51 INFO - 'MAIL': '/var/mail/cltbld', 03:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:51 INFO - 'MOZ_NO_REMOTE': '1', 03:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:51 INFO - 'NO_EM_RESTART': '1', 03:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:51 INFO - 'PWD': '/builds/slave/test', 03:30:51 INFO - 'SHELL': '/bin/bash', 03:30:51 INFO - 'SHLVL': '1', 03:30:51 INFO - 'TERM': 'linux', 03:30:51 INFO - 'TMOUT': '86400', 03:30:51 INFO - 'USER': 'cltbld', 03:30:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:51 INFO - '_': '/tools/buildbot/bin/python'} 03:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:54 INFO - Downloading docopt-0.6.1.tar.gz 03:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:54 INFO - Running setup.py install for blobuploader 03:30:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:54 INFO - Running setup.py install for requests 03:30:54 INFO - Running setup.py install for docopt 03:30:54 INFO - Successfully installed blobuploader requests docopt 03:30:54 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:55 INFO - Running setup.py (path:/tmp/pip-OPQyMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:55 INFO - Running setup.py (path:/tmp/pip-DwYY1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:55 INFO - Running setup.py (path:/tmp/pip-7gZ4dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:55 INFO - Running setup.py (path:/tmp/pip-i4hwBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:55 INFO - Running setup.py (path:/tmp/pip-feISF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:55 INFO - Running setup.py (path:/tmp/pip-vehAVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:55 INFO - Running setup.py (path:/tmp/pip-4brr2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:55 INFO - Running setup.py (path:/tmp/pip-aJsoCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:55 INFO - Running setup.py (path:/tmp/pip-w8ntVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:55 INFO - Running setup.py (path:/tmp/pip-5jzWgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:55 INFO - Running setup.py (path:/tmp/pip-SKY85C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:56 INFO - Running setup.py (path:/tmp/pip-fklc8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:56 INFO - Running setup.py (path:/tmp/pip-_wLIuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:56 INFO - Running setup.py (path:/tmp/pip-syDBQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:56 INFO - Running setup.py (path:/tmp/pip-EO8nK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:56 INFO - Running setup.py (path:/tmp/pip-uLFw5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:56 INFO - Running setup.py (path:/tmp/pip-RzNOvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:56 INFO - Running setup.py install for manifestparser 03:30:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Running setup.py install for mozcrash 03:30:56 INFO - Running setup.py install for mozdebug 03:30:56 INFO - Running setup.py install for mozdevice 03:30:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Running setup.py install for mozfile 03:30:56 INFO - Running setup.py install for mozhttpd 03:30:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozinfo 03:30:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozInstall 03:30:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozleak 03:30:57 INFO - Running setup.py install for mozlog 03:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for moznetwork 03:30:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozprocess 03:30:57 INFO - Running setup.py install for mozprofile 03:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozrunner 03:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozscreenshot 03:30:58 INFO - Running setup.py install for moztest 03:30:58 INFO - Running setup.py install for mozversion 03:30:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:58 INFO - Cleaning up... 03:30:58 INFO - Return code: 0 03:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:58 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 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:30:58 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 03:30:58 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 03:30:58 INFO - Using env: {'DISPLAY': ':0', 03:30:58 INFO - 'HOME': '/home/cltbld', 03:30:58 INFO - 'LANG': 'en_US.UTF-8', 03:30:58 INFO - 'LANGUAGE': 'en_US:en', 03:30:58 INFO - 'LOGNAME': 'cltbld', 03:30:58 INFO - 'MAIL': '/var/mail/cltbld', 03:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:58 INFO - 'MOZ_NO_REMOTE': '1', 03:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:58 INFO - 'NO_EM_RESTART': '1', 03:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:58 INFO - 'PWD': '/builds/slave/test', 03:30:58 INFO - 'SHELL': '/bin/bash', 03:30:58 INFO - 'SHLVL': '1', 03:30:58 INFO - 'TERM': 'linux', 03:30:58 INFO - 'TMOUT': '86400', 03:30:58 INFO - 'USER': 'cltbld', 03:30:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:58 INFO - '_': '/tools/buildbot/bin/python'} 03:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:58 INFO - Running setup.py (path:/tmp/pip-Wi2J07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:58 INFO - Running setup.py (path:/tmp/pip-lcrz6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:58 INFO - Running setup.py (path:/tmp/pip-lJEC_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:58 INFO - Running setup.py (path:/tmp/pip-MTfqon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:58 INFO - Running setup.py (path:/tmp/pip-5nQFCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:58 INFO - Running setup.py (path:/tmp/pip-8c2YPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:58 INFO - Running setup.py (path:/tmp/pip-SMKjQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:58 INFO - Running setup.py (path:/tmp/pip-tlZU3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:59 INFO - Running setup.py (path:/tmp/pip-VWoyvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:59 INFO - Running setup.py (path:/tmp/pip-tyTgwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:59 INFO - Running setup.py (path:/tmp/pip-Sryn0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:59 INFO - Running setup.py (path:/tmp/pip-MeOgoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:59 INFO - Running setup.py (path:/tmp/pip-MElrKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:59 INFO - Running setup.py (path:/tmp/pip-K__p9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:59 INFO - Running setup.py (path:/tmp/pip-dOWG3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:59 INFO - Running setup.py (path:/tmp/pip-7tcq7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:59 INFO - Running setup.py (path:/tmp/pip-9JzCBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:01 INFO - Downloading blessings-1.6.tar.gz 03:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:01 INFO - Installing collected packages: blessings 03:31:01 INFO - Running setup.py install for blessings 03:31:01 INFO - Successfully installed blessings 03:31:01 INFO - Cleaning up... 03:31:02 INFO - Return code: 0 03:31:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:02 INFO - Reading from file tmpfile_stdout 03:31:02 INFO - Current package versions: 03:31:02 INFO - argparse == 1.2.1 03:31:02 INFO - blessings == 1.6 03:31:02 INFO - blobuploader == 1.2.4 03:31:02 INFO - docopt == 0.6.1 03:31:02 INFO - manifestparser == 1.1 03:31:02 INFO - mozInstall == 1.12 03:31:02 INFO - mozcrash == 0.17 03:31:02 INFO - mozdebug == 0.1 03:31:02 INFO - mozdevice == 0.48 03:31:02 INFO - mozfile == 1.2 03:31:02 INFO - mozhttpd == 0.7 03:31:02 INFO - mozinfo == 0.9 03:31:02 INFO - mozleak == 0.1 03:31:02 INFO - mozlog == 3.1 03:31:02 INFO - moznetwork == 0.27 03:31:02 INFO - mozprocess == 0.22 03:31:02 INFO - mozprofile == 0.28 03:31:02 INFO - mozrunner == 6.11 03:31:02 INFO - mozscreenshot == 0.1 03:31:02 INFO - mozsystemmonitor == 0.0 03:31:02 INFO - moztest == 0.7 03:31:02 INFO - mozversion == 1.4 03:31:02 INFO - psutil == 3.1.1 03:31:02 INFO - requests == 1.2.3 03:31:02 INFO - wsgiref == 0.1.2 03:31:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:02 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 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:31:02 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 03:31:02 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 03:31:02 INFO - Using env: {'DISPLAY': ':0', 03:31:02 INFO - 'HOME': '/home/cltbld', 03:31:02 INFO - 'LANG': 'en_US.UTF-8', 03:31:02 INFO - 'LANGUAGE': 'en_US:en', 03:31:02 INFO - 'LOGNAME': 'cltbld', 03:31:02 INFO - 'MAIL': '/var/mail/cltbld', 03:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:02 INFO - 'MOZ_NO_REMOTE': '1', 03:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:02 INFO - 'NO_EM_RESTART': '1', 03:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:02 INFO - 'PWD': '/builds/slave/test', 03:31:02 INFO - 'SHELL': '/bin/bash', 03:31:02 INFO - 'SHLVL': '1', 03:31:02 INFO - 'TERM': 'linux', 03:31:02 INFO - 'TMOUT': '86400', 03:31:02 INFO - 'USER': 'cltbld', 03:31:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:02 INFO - '_': '/tools/buildbot/bin/python'} 03:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 INFO - Cleaning up... 03:31:02 INFO - Return code: 0 03:31:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:31: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', 'jsonschema'] in /builds/slave/test/build 03:31: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 jsonschema 03:31:02 INFO - Using env: {'DISPLAY': ':0', 03:31:02 INFO - 'HOME': '/home/cltbld', 03:31:02 INFO - 'LANG': 'en_US.UTF-8', 03:31:02 INFO - 'LANGUAGE': 'en_US:en', 03:31:02 INFO - 'LOGNAME': 'cltbld', 03:31:02 INFO - 'MAIL': '/var/mail/cltbld', 03:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:02 INFO - 'MOZ_NO_REMOTE': '1', 03:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:02 INFO - 'NO_EM_RESTART': '1', 03:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:02 INFO - 'PWD': '/builds/slave/test', 03:31:02 INFO - 'SHELL': '/bin/bash', 03:31:02 INFO - 'SHLVL': '1', 03:31:02 INFO - 'TERM': 'linux', 03:31:02 INFO - 'TMOUT': '86400', 03:31:02 INFO - 'USER': 'cltbld', 03:31:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:02 INFO - '_': '/tools/buildbot/bin/python'} 03:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:02 INFO - Downloading/unpacking jsonschema 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:04 INFO - Downloading/unpacking functools32 (from jsonschema) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:04 INFO - warning: no files found matching '*.txt' 03:31:04 INFO - no previously-included directories found matching 'build' 03:31:04 INFO - no previously-included directories found matching 'dist' 03:31:04 INFO - no previously-included directories found matching '.git*' 03:31:04 INFO - Installing collected packages: jsonschema, functools32 03:31:04 INFO - Running setup.py install for functools32 03:31:05 INFO - warning: no files found matching '*.txt' 03:31:05 INFO - no previously-included directories found matching 'build' 03:31:05 INFO - no previously-included directories found matching 'dist' 03:31:05 INFO - no previously-included directories found matching '.git*' 03:31:05 INFO - Successfully installed jsonschema functools32 03:31:05 INFO - Cleaning up... 03:31:05 INFO - Return code: 0 03:31:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:05 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 0x7f6145010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', '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 03:31:05 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 03:31:05 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 03:31:05 INFO - Using env: {'DISPLAY': ':0', 03:31:05 INFO - 'HOME': '/home/cltbld', 03:31:05 INFO - 'LANG': 'en_US.UTF-8', 03:31:05 INFO - 'LANGUAGE': 'en_US:en', 03:31:05 INFO - 'LOGNAME': 'cltbld', 03:31:05 INFO - 'MAIL': '/var/mail/cltbld', 03:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:05 INFO - 'MOZ_NO_REMOTE': '1', 03:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:05 INFO - 'NO_EM_RESTART': '1', 03:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:05 INFO - 'PWD': '/builds/slave/test', 03:31:05 INFO - 'SHELL': '/bin/bash', 03:31:05 INFO - 'SHLVL': '1', 03:31:05 INFO - 'TERM': 'linux', 03:31:05 INFO - 'TMOUT': '86400', 03:31:05 INFO - 'USER': 'cltbld', 03:31:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:05 INFO - '_': '/tools/buildbot/bin/python'} 03:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:05 INFO - Downloading/unpacking flake8 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:07 INFO - no previously-included directories found matching 'docs/_build' 03:31:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:08 INFO - Running setup.py install for pep8 03:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:08 INFO - no previously-included directories found matching 'docs/_build' 03:31:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:08 INFO - Cleaning up... 03:31:08 INFO - Return code: 0 03:31:08 INFO - Running post-action listener: _resource_record_post_action 03:31:08 INFO - Running post-action listener: _start_resource_monitoring 03:31:08 INFO - Starting resource monitoring. 03:31:08 INFO - ##### 03:31:08 INFO - ##### Running install step. 03:31:08 INFO - ##### 03:31:08 INFO - Running pre-action listener: _resource_record_pre_action 03:31:08 INFO - Running main action method: install 03:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:08 INFO - Reading from file tmpfile_stdout 03:31:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:08 INFO - Reading from file tmpfile_stdout 03:31:08 INFO - Output received: 03:31:08 INFO - Usage: mozinstall [options] installer 03:31:08 INFO - Options: 03:31:08 INFO - -h, --help show this help message and exit 03:31:08 INFO - -d DEST, --destination=DEST 03:31:08 INFO - Directory to install application into. [default: 03:31:08 INFO - "/builds/slave/test"] 03:31:08 INFO - --app=APP Application being installed. [default: firefox] 03:31:08 INFO - mkdir: /builds/slave/test/build/application 03:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:31:24 INFO - Reading from file tmpfile_stdout 03:31:24 INFO - Output received: 03:31:24 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:24 INFO - Running post-action listener: _resource_record_post_action 03:31:24 INFO - ##### 03:31:24 INFO - ##### Running run-tests step. 03:31:24 INFO - ##### 03:31:24 INFO - Running pre-action listener: _resource_record_pre_action 03:31:24 INFO - Running main action method: run_tests 03:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:24 INFO - Python 2.7.3 03:31:24 INFO - Return code: 0 03:31:24 INFO - grabbing minidump binary from tooltool 03:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:24 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 0x1c67410>, '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 0x1c68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c687a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:24 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 03:31:24 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 03:31:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:24 INFO - Return code: 0 03:31:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:31:25 INFO - Return code: 0 03:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:31:25 INFO - Using env: {'DISPLAY': ':0', 03:31:25 INFO - 'HOME': '/home/cltbld', 03:31:25 INFO - 'LANG': 'en_US.UTF-8', 03:31:25 INFO - 'LANGUAGE': 'en_US:en', 03:31:25 INFO - 'LOGNAME': 'cltbld', 03:31:25 INFO - 'MAIL': '/var/mail/cltbld', 03:31:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:25 INFO - 'MOZ_NO_REMOTE': '1', 03:31:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:25 INFO - 'NO_EM_RESTART': '1', 03:31:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:25 INFO - 'PWD': '/builds/slave/test', 03:31:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:25 INFO - 'SHELL': '/bin/bash', 03:31:25 INFO - 'SHLVL': '1', 03:31:25 INFO - 'TERM': 'linux', 03:31:25 INFO - 'TMOUT': '86400', 03:31:25 INFO - 'USER': 'cltbld', 03:31:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595', 03:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:25 INFO - '_': '/tools/buildbot/bin/python'} 03:31:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:31:25 INFO - mozversion application_buildid: 20160518004015 03:31:25 INFO - mozversion application_changeset: b4e6080db0238862dfb893ea6ab564fcd4375da1 03:31:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:25 INFO - mozversion application_name: Firefox 03:31:25 INFO - mozversion application_remotingname: firefox-dev 03:31:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:25 INFO - mozversion application_vendor: Mozilla 03:31:25 INFO - mozversion application_version: 48.0a2 03:31:25 INFO - mozversion platform_buildid: 20160518004015 03:31:25 INFO - mozversion platform_changeset: b4e6080db0238862dfb893ea6ab564fcd4375da1 03:31:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:25 INFO - mozversion platform_version: 48.0a2 03:31:25 INFO - using testdate: 1463567485 03:31:25 INFO - actual date: 1463567485 03:31:25 INFO - starting webserver on 'localhost:42880' 03:31:25 INFO - SUITE-START | Running 2 tests 03:31:25 INFO - TEST-START | dromaeo_css 03:31:25 INFO - operating with platform_type : linux_ 03:31:25 INFO - Initialising browser for dromaeo_css test... 03:31:25 INFO - TEST-INFO | started process 3326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq6iRoM/profile http://localhost:42880/getInfo.html) 03:31:31 INFO - PROCESS | 3326 | __metrics Screen width/height:1600/1200 03:31:31 INFO - PROCESS | 3326 | colorDepth:24 03:31:31 INFO - PROCESS | 3326 | Browser inner width/height: 1024/697 03:31:31 INFO - PROCESS | 3326 | __metrics 03:31:32 ERROR - PROCESS | 3326 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:31:33 INFO - TEST-INFO | 3326: exit 0 03:31:33 INFO - Browser initialized. 03:31:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:33 INFO - TEST-INFO | started process 3415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq6iRoM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:44 INFO - PROCESS | 3415 | RSS: Main: 142098432 03:31:44 INFO - PROCESS | 3415 | 03:32:35 INFO - PROCESS | 3415 | 1463567555961 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] 03:34:43 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:42880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42880/tests/dromaeo/cssquery-ext.html) 03:34:44 INFO - PROCESS | 3415 | RSS: Main: 248864768 03:34:44 INFO - PROCESS | 3415 | 03:37:46 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:42880/tests/dromaeo/cssquery-ext.html (next: http://localhost:42880/tests/dromaeo/cssquery-jquery.html) 03:37:47 INFO - PROCESS | 3415 | RSS: Main: 222519296 03:37:47 INFO - PROCESS | 3415 | 03:40:49 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:42880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42880/tests/dromaeo/cssquery-mootools.html) 03:40:50 INFO - PROCESS | 3415 | RSS: Main: 217214976 03:40:50 INFO - PROCESS | 3415 | 03:43:51 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:42880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42880/tests/dromaeo/cssquery-prototype.html) 03:43:52 INFO - PROCESS | 3415 | RSS: Main: 217247744 03:43:52 INFO - PROCESS | 3415 | 03:46:54 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:42880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42880/tests/dromaeo/cssquery-yui.html) 03:46:55 INFO - PROCESS | 3415 | RSS: Main: 213495808 03:46:55 INFO - PROCESS | 3415 | 03:49:57 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:42880/tests/dromaeo/cssquery-yui.html (next: http://localhost:42880/tests/dromaeo/cssquery-dojo.html) 03:49:58 INFO - PROCESS | 3415 | RSS: Main: 247300096 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | __start_tp_report 03:49:58 INFO - PROCESS | 3415 | _x_x_mozilla_page_load 03:49:58 INFO - PROCESS | 3415 | _x_x_mozilla_page_load_details 03:49:58 INFO - PROCESS | 3415 | |i|pagename|runs| 03:49:58 INFO - PROCESS | 3415 | |0;dojo.html;3257.299680568678;3311.850966706498;3340.816255105969;3357.3956687796217;3373.3421982713367;5415.891682166354;5434.538064264542;5436.700981446019;5448.3734370547345;5465.262189604402;5455.972720136394;5463.7814487420455;5471.06991811392;5475.315585551806;5496.560275177986;4771.761411929407;4850.951490485103;4925.581325587329;4995.65030447867;5051.898962020776;4862.708237505761;4884.145274576953;4901.338319326881;4907.2148456247005;4907.75461226939;4922.80308787648;4974.801007959677;4995.850124496253;5004.474530174334;5020.0963826511215;5051.570616497602;5069.974650126745;5071.695698258116;5074.112030394666;5079.03498335317;4812.446568644581;4829.082474329901;4875.634327425457;4967.254911763264;5006.998600279922;5426.321709786277;5450.482204190595;5474.562035037187;5489.478499542577;5496.945030549683;5918.141869428951;5952.077427998667;5952.7023648817385;5952.7321270542925;5953.315368732608;5931.822045338647;5950.9702451487465;5961.850953726148;6007.849803754897;6020.518358531351;5447.509724124809;5453.127499600045;5457.890842183174;5476.342838859323;5479;5815.156802263733;5921.96365636012;5923.49650279731;5929.3181284152015;5931.199288096138;5704.857378565486;5752.654840709487;5758.74085666146;5766.192733017381;5816.88366232673;5756;5773.076307790818;5776.624519406225;5779.248697669276;5790.160426738099;5606.747696353674;5741.684207368635;5747.339056008529;5751.798687046017;5758;5756.481916627524;5758.452946970031;5759.1937128802;5793.652380857162;5799.739011744482;4293.957060429419;4297.763623000703;4309.913801723948;4311.6335111515245;4331.566843315706;3816.790076545761;3850.2299540092095;3912.39357899526;3917.7061720371084;3936.3308237599676;5519.144532597454;5529.391766905637;5534.501894829485;5546.251256080377;5568.16477528374;5873.882522349614;5880.588358814842;5883.352831188566;5890.175375447441;5891.263592050994;5388.7305634718105;5552.52803511706;5646.661200327993;5701.315842098975;5706.514946229534;4834.685745426536;4860.3195552622665;4862.5380588844;4866.221404575251;4894.583960363338;5974.253218347707;5984.850378740566;5987.1318658794235;5987.9101813472835;6000.069989151689;5736.082226843685;5889.175515427758;5964.165016897551;5973.49225315853;5993.310769261417;6049.727762250797;6062.272527296753;6065.150878877049;6072.180255665606;6077.058056001327;5750.654960702372;5754.827355179351;5757.107648314518;5757.395473475225;5759.94240057594;5726.570507212059;5886.23478947734;5952.702364881652;5956.76172953077;5989.460948514655;5700.230468886647;5703;5704.3154821421695;5710.5717071219;5712.057510510886;5617.466340697627;5650.886982260414;5701.743421545957;5706.058500347396;5715.085586306171;5625.971870140623;5639.210510528447;5672.60291779588;5694;5706.28671416073;5723.255976723;5743.56923230751;5754.539636829128;5758.769649213985;5788.450097240755;5462.863428414322;5624.3250809903075;5678.4605462480995;5685.800996965252;5689.800856969986 03:49:58 INFO - PROCESS | 3415 | |1;ext.html;598.4583951523872;661.0843981086196;664.2029564522568;665.3246954341342;676.2223443040502;33934.321313573746;34604.65395346046;34713.65286347139;34864.651353486486;34889.12777180572;35035.29929401417;35711.642883571156;42175;42566.57433425665;42681.57318426815;8877.866831997526;9006.639734410648;9022.684206052789;9028.77428064297;9033.09669033098;8805.779855503599;8998.730038098867;9005.234555062827;9009.099090091004;9009.909900900973;8402.915970840275;8720.34597405194;10940.671779846578;11248.15638827087;11260.155488338367;10671.612690350243;10748.247622666417;10762.192835537287;10782.353058816496;10786.08318292946;8341.41610087294;10509.264351495398;10619.30974486656;10623.20325975555;10628.681139565826;40410.59589404098;40712.185756285005;40740.185196295904;40766.388504172464;40813.591864081274;3937.7243592948507;4061.97969010156;4189.413482112506;4387.94689274575;4494.359747031186;34605.82697086524;34821.30357392838;34902.476462853076;35092.649073509194;35122;4551.180787458289;4606.286025666027;4609.815607375701;4617.953820461786;4646.372739680134;323726;326105;326121.9999999976;326233;326460;60874.39125608776;68563.31436685669;69215;69405;71111.64444177746;67460.32539674638;68063;68167;68204.31795682079;68224;18813.341533046278;18835.152418140944;19003;19027.14377853;19033.524161896064;14854.405823767145;14935.25323733809;14959.850401495845;14960.40158393652;14972.550823475312;19036;20572.79427205739;20791.58416831685;21022.579548408947;21599;7664.31021208094;7923.7226697065325;7978.760637180894;7981.281684648409;8057.952466179359;1156.803343431602;1181.6218809980896;1188.423614546944;1218.6283183629077;1277.7125146842072;34506.96139657243;34971.30057398838;35102.824485877914;35174.82412587972;35784;1209.2744353388073;1241.422738426636;1250.6748245456247;1328.88373766037;1355.213975893979;18077.457676269732;18163.45509634713;18445.90777046106;18492.35276765307;18528;221417;222818;223301;223499;223580;63772.36227637757;65107.67446162834;65147.348526515074;65152.34847651557;65452;1373.1006190944947;1465.8754005909404;1507.5376884422094;1521.4598817420099;1612.8225895151525;30345.848270758506;32589.511157333134;32754.67245327516;33877.83061084679;33959.19670062719;51230.23154652608;51695.741521292155;51809;51855.481445186575;51879.740601296755;306008;306306;307243;307708;309167;40314.798426007685;46011.22563931987;46688.29967550557;50816;51229;49885.25172122494;50262;51179.744101279255;53370;56229.437705624056;40567;42062.57937420709;42457.57542424536;42677.35983960181;42856.57143428526;41770.164596708506;42131.39383326505;42365.36451953161;42551.574484254765;42557.148857023305;44805.77597111993;45081.549184507734;45447.545524545654;45846.77076614596;45935;33324.257560530816;37919.62080379271;38186.618133819415;38351.42472862853;38722.80638596789;29183.270418239714;29485.447684937957;29549.852250738608;29551.408971820012;30110.397792043597 03:49:58 INFO - PROCESS | 3415 | |2;jquery.html;420.5500114877083;420.730732331308;427.2715020889382;427.730529766247;436.90169711814843;18910.243590256392;19484.318048868292;19495.41513754588;19810.10854511547;20740.170393184293;18568.16443260053;18913.338033168842;20407.59184816303;20429.795702042975;20447.795522044777;5019.247112933052;5038.445770965191;5228.79084836606;5254.106801843695;5254.842354729364;4005.1989602079557;5228.895422091556;5232.2674825524455;5420.268263784378;5715;5677.716114194273;5704.629199102066;5707.315122185343;5711.428857114276;5737.913931291034;5357.43746906577;5591.776328946838;5604.915926261109;5702.173184888189;5706.77172913083;3870.845166193349;5281.86795330116;5509.559235261169;5515.917261241085;5525.889482210374;13139.671508212276;13218.867811321956;17878.642427151513;22182.112715491523;22183.11267549296;2284.22972196549;2360.091364824555;2408.6146216605257;2517.471331020488;2937.8531073446243;9917.553710083064;10036.29745917786;10045.14616257619;10102.040306170902;10428.843567346496;1830.9542261443437;1985.553250518636;2009.1159889648654;2035.236786205173;2059.52630894895;78418.60790696066;80325.99999999942;84782.15217847805;87298.5635071827;88541.11458885393;11421.942890285496;11608.883911160949;11627.12796540263;11630.941845290889;11953.46209420578;16863.91568042152;16874;17007.31970721182;17048.914755426144;17066.146692665316;8713.564321783886;8869.600867960957;8928.687495937611;9106.86339704905;9123.863142052875;8892;8951.641934322684;8955.686550970684;8970.282377409792;8983.371164018587;5123.308353372322;5137.640365174402;5142.820001299937;5178.689278643218;5199.402068762065;1881.2851116575614;2044.877307361563;2047.396018174642;2129.052571605652;2156.6872803443725;1023.5505898805314;1065.79217052674;1066.893310668927;1087.8259478483405;1101.3061771084165;18347.63304733898;18921.62156756857;19113.713294300596;19152.52118697016;19927.701084483746;1074.1245884604023;1088.450332582041;1094.1192340166242;1111.5276007696696;1124.4658787076073;10662.786744265226;10981.341119532854;11004.284721493077;11132.886711328802;11152.832707509393;516237;526449;551661;552918;557644;105997.47001264944;110111;110144.4492777531;110411;110839.44580277208;1128.3963079752293;1143.3654321851286;1155.641751057175;1195.2171327780318;1198.6404078776332;17332.653346933243;17955.910220448815;18026.90986545059;18172.36396726108;18493.9075304628;39548.604513954495;40473.1905361897;40714.18571628492;41112.44263004257;41173.79413102915;52616;53466.19800702915;53475.73262133665;53519.732401337744;54116.72941635267;8339.791505212419;8446.915530844859;8512.276456501018;8521.318294536546;8530.317574593893;13099.934500327437;13379.598612041655;13403.664908377368;13446.663833404244;13516.662083447993;11565.248258863146;11615.88384116148;11670.88329116698;11915.52337906474;12257.958073563846;11402.48688808989;11501.769964600828;11667.766644667228;11693.941530292293;11741.471633776671;9705.854412183682;11568.190226684052;12011.459484323052;12040.819387709016;12101.515939362327;8376.329893608376;8425.199606037417;8534.274586660204;8692.956535217283;8733.519656418704;10688.57245710194;11350.772984540428;11496.88503114958;11501.539938402704;11967.281963082243 03:49:58 INFO - PROCESS | 3415 | |3;mootools.html;1388;1548.8141423029238;1568.0199875078076;1762.51530829022;1863.9440816775502;7954.482958607694;8078.990126234221;8120.959395203023;8140.1452847451055;8141.06377766557;8197.508149511033;8358.498490090598;8371.91628083719;8383.203595658402;8395.118512556186;2128.88291143987;2167.4039639099296;2376.227725989052;2424.369663887389;2461.7661322174454;2445.6209287560455;2481.813863960201;2486.477839653675;2489.73857744936;2491.5141547398266;2372.50177462733;2406.4946361264156;2408.4460574067975;2426.672399226108;2429.8056155507516;2077.4910147014;2347.7534858839917;2402.3753824005707;2415.6738840256517;2426.162973774045;2345.4839935214227;2357.4931389751287;2393.7366889642126;2399.5320912422085;2399.748026457214;8185.836283274301;8197.0573384061;8237.83524329516;8249.133840946733;8258.843761873342;5225.581953443715;5358.169483730028;5388.73056347185;5390.649607775482;5392.299001129828;3397.8470968806214;3436.8453419596176;3488.982555087234;3526.770759900598;3574.7318951078514;1129.807932651443;1144.3877525523887;1171.1275100050432;1191.53530123252;1214.0409076829294;12335.259884406963;12490.12569120171;12529.686757831036;12533.060020498408;12555.435005424777;4638.6752927294765;4667.879708869915;4728.1252968201;4756.6432517561325;4762.238041913277;10733.141348692086;10764.085052770446;10766.676999690022;10783.245172837826;10788.244822862482;5436.510714035756;5471;5479.698616576126;5481.314835645544;5483.643563168382;4228.23891699497;4726.503717109723;4746.169420351424;4750.928736068961;4803.759812009455;4130.112025914383;4142.171565686875;4153.896152596149;4181.916361672749;4233.026403927052;1346.3604787725947;1391.9234442105578;1411.4283715095403;1414.985850141506;1424.273620453576;1034.9586016559404;1038.948052597367;1051.8790339111101;1063.42575009494;1066.6799960011965;5997.640141591519;6021.458068773832;6051.213342265565;6074.240719910012;6263.091851681481;448.7038554554044;449.49656384848527;450.8264318237502;454.42969073812156;455.2533844495031;4120.196561670446;4301.741895486281;4418.248897687401;4498.122866041091;4525.321201819754;9987.201023918069;10186;10229.07938285543;10247.692569222936;10257.743556411;10148.340357876714;10157.441340726331;10307.072363487323;10309.484525773682;10336.276460647683;8407.495550267004;8435.409521333448;8529.360297977677;8558;8560.101189375151;6004.729787159501;6151.784687536094;6182.443580077635;6203.16257305258;6282.623042617458;9674.226061915171;9695.272854536079;9757.46333951611;9822.557984890555;9940.304178707422;9912.454814985245;9968;10028.849567256351;10189.235807314333;10198.082172604501;6772.966135169293;6974.930250697631;7325.084364454443;7533.698652053857;7694.730684426018;8396.790080247798;8398.370122240978;8430.15698430152;8459;8466.322694184328;7441.479096463412;7447.851042979001;7469.327354703861;7671.07947046358;7689.115751688628;7139.643017849191;7160.57036577807;7179.174394944648;7246.130464344313;7283.817904552428;6901.206361268318;6914.0666010088;6965.721371145098;6978.267281935324;6981.301869812978;5125.205593133071;5130.666026833125;5214.921776173436;5316.521513063843;5377.596680249075;5254;5292.497212764782;5399.028174928393;5406.216098665593;5408.567314614743 03:49:58 INFO - PROCESS | 3415 | |4;prototype.html;332.6158287178308;334.5400074897017;337.59825807289315;341.42469938154227;343.66664335594464;6200.751969921203;6256.84357891053;6264.373562643734;6301.936980630192;6330.588511746739;6165.564601982225;6222.782202622898;6235.844103897405;6247.687615619212;6248.812535623927;4479.216137175998;4554.817807287704;4657.930131048037;4659.673822832403;4673.532646735316;4661.230896902007;4684.344191813132;4685.109829132471;4701.976490117545;4710.599599034086;4433.113377324532;4658.487566367714;4660.813567457298;4668.276417155346;4668.603168730645;4548.454185497745;4661.81352745888;4662.347271382009;4669.533046695304;4681.063787242531;4061.6547593454593;4063.4920634920636;4076.286649836267;4077.1845630873945;4080.4287399764057;5943.3759455257;5954.8809023819285;5955.225820643332;5958.463738263534;5967.1347654589845;5393.4336894626285;5424.484673955968;5432.049391356497;5432.674039557639;5439.0209762242785;6503.382178693017;6512.446442052431;6516.055172000081;6522.608643481359;6523.119378883837;4279.957200427987;4393.890152746175;4402.053558484941;4407.250767369523;4418.734875907456;6704.463642908604;6830.351116643911;6851.520393572452;6866.107406037283;6867.828304292383;4493.775311234425;4511.954880451219;4515.029268707243;4518.390017347681;4520.796564154621;4567.109413664303;4571.862844114682;4573.5426457354;4574.45106587205;4575.405197324393;5343.091674415358;5344.545713614309;5345.572354211654;5348.973255133699;5350.3312085989255;6420.165378500765;6596.80209593713;6609.306022867626;6635.767748128792;6642.96678516614;1586.476462767284;1600.4558450127013;1609.7263465210942;1609.8148712897932;1612.5807290104422;977.5552123783662;978.9951050244703;1023.65195833417;1049.5014867937668;1049.5277125293649;6251.374862513712;6330.082138090043;6349.079383489368;6352.2694890087305;6363;6754.45964322853;6777;6783.830404239933;6793.932060679429;6867.3476019778045;6319.778807741799;6332.430081292614;6333.398327158912;6337.176167098248;6343.0485427186295;3627.147620309225;3629.1108678373967;3654.8903532893523;3657.8112113563197;3664.72514561409;6899.206591241971;7158;7162.892556611655;7175.964120179366;7180.31786980236;6994.545354551938;7034.2965703429245;7042.436605071582;7049.118860142482;7052.929470705228;6990.965045174741;7024.262452442522;7037.296270372922;7044.049053377831;7052.259512751088;6859.142607174103;6859.211190713132;6865.622390768555;6867.725290988305;6879.828004299732;6564.6389448578875;6768.4585233182215;6770.5599136056;6776.322367763184;6779.423748981392;7137.393321567725;7139.107611548557;7145.85708285821;7152.964235178791;7157.57054576727;4506.233940230103;4527.796249168729;4535.659825513034;4554.567316104964;4559.430071241095;6848.657567121524;6859.588424694534;6861.245263020964;6861.965690171517;6869.931300687129;6506;6644.169478815148;6651.368120028589;6661.3338666132995;6662.83342916431;6600.60396376219;6640;6646.734130634721;6647.534672573067;6666.400023997863;6545.345465453607;6547.443467305142;6555.704993275219;6556.213254409501;6556.5738227017;6724.361185687352;6735.831604209934;6777.6272305023695;6797.592144471348;6806.047153398627;6450.967745161244;6550.410463058348;6577.80266592003;6578;6580.605163690194 03:49:58 INFO - PROCESS | 3415 | |5;yui.html;850.7745447456422;866.246365661874;876.8071024374635;915.2702736349376;935.2658163341778;14231.92884035581;14716.852831471695;14845.109293442401;14853.183074930874;14938.327775250113;13872.37574309156;13887.305634718248;13900.860991390084;13942;13951.441942322295;748.962551872407;873.4060838629729;888.835565420396;902.4224496322358;911.5077857956728;896.224765577777;899.6941040046383;904.9864252036225;905.0225756183339;905.4612505559181;935.5836652689555;936.494293081735;937.4515908193681;938.8497840345547;939.3940908114262;781.0978320040363;922.7739203895021;931.417863835103;934.042606328512;934.5467448287575;682.4199430484049;682.9112215412015;682.9795106146773;685.348918527401;687.8521117959613;14604.853951460456;14681.119132852064;14684.898632602597;14695.63260918475;14709.779353309601;14750.483733069292;15083.773743393858;15159.696806063926;15168.393264269416;15298.617534561614;12097.684644179933;12150.696232594168;12162.878371216262;12394.938025309906;12440.875591244063;4035.959640403588;4042.898927526806;4052.817623206933;4185.560516145822;4199.496060472732;53758.73120634372;53873.99999999961;56548;56549;56607.433925660625;10155.695329140137;10324;10484.842727359095;10629.946850265855;10643.308184968108;19837.30569430063;19856.801431985783;19861;20037.799622003884;20547.897260513902;8925.152110549487;9035.232005279493;9044.8643270351;9059.954700226457;9075.50084745332;5004;5065.721385323843;5104.259882317043;5104.872378190575;5209.583233341324;3352.4133276676484;3387.2209391840015;3388.102152929476;3389.7966122032262;3393.8472768725464;624.4036944717784;624.4036944717784;633.8542135308904;635.7520566978882;668.5721138471382;648.9870202595922;663.5620490476263;672.5191488086042;675.2909445082644;691.7371398868398;8393.06025341107;8719.389642725075;8780.604872780612;8833.293336533063;9239.195260625878;649.331188875459;670.4368330602219;675.7026908160394;681.2302098628518;683.9760608378683;4343.348497725303;4461.353103799996;4607.976960115245;4617.39842922521;4625.236835922103;59700.70149649224;62422.68788656028;63797.36202638007;64060.35939640544;64245;59543.70228148832;59569.40430595725;60711.69644151839;61451.6927415369;61760.69119654373;52489.737551312;52541.737291314064;55153.172702409494;55978.44021559732;56434.15348769772;8413.158684131538;8502.107278735892;8524.70163544273;8872.24585910205;9080;38084.619153808104;38768.41847372348;38934.22131557296;39083;39721;44378.77810610926;44521.33218001668;47644.7617761909;48041.27938081002;55388.44611553994;12370.62888113358;12448.25310481374;12624.810627840774;12644;13119.147255428366;12896.684680005374;12979.740405192033;13354.265515396746;13454.26001569884;13475.663108422368;12194.390280485763;12463.750724985632;12663.620091397273;12803.80794288105;12809.551665691655;12689.682757930756;12795.360231988177;12990.155639883378;13059.608211753663;13489.123206991515;12649.683757906127;12778;12832.101752877208;13354;13376.799348009594;10276.794464110826;10424.843627345748;10750.677479675622;10830.241883068109;11001.394923278976;8951.73144805657;9003.459792412476;9124.224440922597;9139.086091391073;9146.405483643543 03:49:58 INFO - PROCESS | 3415 | __end_tp_report 03:49:58 INFO - PROCESS | 3415 | __start_cc_report 03:49:58 INFO - PROCESS | 3415 | _x_x_mozilla_cycle_collect,844 03:49:58 INFO - PROCESS | 3415 | __end_cc_report 03:49:58 INFO - PROCESS | 3415 | __startTimestamp1463568598216__endTimestamp 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | ------- Summary: start ------- 03:49:58 INFO - PROCESS | 3415 | Number of tests: 6 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | [#0] dojo.html Cycles:165 Average:5421.99 Median:5685.80 stddev:622.07 (10.9%) stddev-sans-first:600.36 03:49:58 INFO - PROCESS | 3415 | Values: 3257.3 3311.9 3340.8 3357.4 3373.3 5415.9 5434.5 5436.7 5448.4 5465.3 5456.0 5463.8 5471.1 5475.3 5496.6 4771.8 4851.0 4925.6 4995.7 5051.9 4862.7 4884.1 4901.3 4907.2 4907.8 4922.8 4974.8 4995.9 5004.5 5020.1 5051.6 5070.0 5071.7 5074.1 5079.0 4812.4 4829.1 4875.6 4967.3 5007.0 5426.3 5450.5 5474.6 5489.5 5496.9 5918.1 5952.1 5952.7 5952.7 5953.3 5931.8 5951.0 5961.9 6007.8 6020.5 5447.5 5453.1 5457.9 5476.3 5479.0 5815.2 5922.0 5923.5 5929.3 5931.2 5704.9 5752.7 5758.7 5766.2 5816.9 5756.0 5773.1 5776.6 5779.2 5790.2 5606.7 5741.7 5747.3 5751.8 5758.0 5756.5 5758.5 5759.2 5793.7 5799.7 4294.0 4297.8 4309.9 4311.6 4331.6 3816.8 3850.2 3912.4 3917.7 3936.3 5519.1 5529.4 5534.5 5546.3 5568.2 5873.9 5880.6 5883.4 5890.2 5891.3 5388.7 5552.5 5646.7 5701.3 5706.5 4834.7 4860.3 4862.5 4866.2 4894.6 5974.3 5984.9 5987.1 5987.9 6000.1 5736.1 5889.2 5964.2 5973.5 5993.3 6049.7 6062.3 6065.2 6072.2 6077.1 5750.7 5754.8 5757.1 5757.4 5759.9 5726.6 5886.2 5952.7 5956.8 5989.5 5700.2 5703.0 5704.3 5710.6 5712.1 5617.5 5650.9 5701.7 5706.1 5715.1 5626.0 5639.2 5672.6 5694.0 5706.3 5723.3 5743.6 5754.5 5758.8 5788.5 5462.9 5624.3 5678.5 5685.8 5689.8 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | [#1] ext.html Cycles:180 Average:49031.27 Median:38053.12 stddev:75218.58 (197.7%) stddev-sans-first:75341.68 03:49:58 INFO - PROCESS | 3415 | Values: 598.5 661.1 664.2 665.3 676.2 33934.3 34604.7 34713.7 34864.7 34889.1 35035.3 35711.6 42175.0 42566.6 42681.6 8877.9 9006.6 9022.7 9028.8 9033.1 8805.8 8998.7 9005.2 9009.1 9009.9 8402.9 8720.3 10940.7 11248.2 11260.2 10671.6 10748.2 10762.2 10782.4 10786.1 8341.4 10509.3 10619.3 10623.2 10628.7 40410.6 40712.2 40740.2 40766.4 40813.6 3937.7 4062.0 4189.4 4387.9 4494.4 34605.8 34821.3 34902.5 35092.6 35122.0 4551.2 4606.3 4609.8 4618.0 4646.4 323726.0 326105.0 326122.0 326233.0 326460.0 60874.4 68563.3 69215.0 69405.0 71111.6 67460.3 68063.0 68167.0 68204.3 68224.0 18813.3 18835.2 19003.0 19027.1 19033.5 14854.4 14935.3 14959.9 14960.4 14972.6 19036.0 20572.8 20791.6 21022.6 21599.0 7664.3 7923.7 7978.8 7981.3 8058.0 1156.8 1181.6 1188.4 1218.6 1277.7 34507.0 34971.3 35102.8 35174.8 35784.0 1209.3 1241.4 1250.7 1328.9 1355.2 18077.5 18163.5 18445.9 18492.4 18528.0 221417.0 222818.0 223301.0 223499.0 223580.0 63772.4 65107.7 65147.3 65152.3 65452.0 1373.1 1465.9 1507.5 1521.5 1612.8 30345.8 32589.5 32754.7 33877.8 33959.2 51230.2 51695.7 51809.0 51855.5 51879.7 306008.0 306306.0 307243.0 307708.0 309167.0 40314.8 46011.2 46688.3 50816.0 51229.0 49885.3 50262.0 51179.7 53370.0 56229.4 40567.0 42062.6 42457.6 42677.4 42856.6 41770.2 42131.4 42365.4 42551.6 42557.1 44805.8 45081.5 45447.5 45846.8 45935.0 33324.3 37919.6 38186.6 38351.4 38722.8 29183.3 29485.4 29549.9 29551.4 30110.4 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | [#2] jquery.html Cycles:180 Average:30808.90 Median:11247.60 stddev:89374.75 (794.6%) stddev-sans-first:89596.35 03:49:58 INFO - PROCESS | 3415 | Values: 420.6 420.7 427.3 427.7 436.9 18910.2 19484.3 19495.4 19810.1 20740.2 18568.2 18913.3 20407.6 20429.8 20447.8 5019.2 5038.4 5228.8 5254.1 5254.8 4005.2 5228.9 5232.3 5420.3 5715.0 5677.7 5704.6 5707.3 5711.4 5737.9 5357.4 5591.8 5604.9 5702.2 5706.8 3870.8 5281.9 5509.6 5515.9 5525.9 13139.7 13218.9 17878.6 22182.1 22183.1 2284.2 2360.1 2408.6 2517.5 2937.9 9917.6 10036.3 10045.1 10102.0 10428.8 1831.0 1985.6 2009.1 2035.2 2059.5 78418.6 80326.0 84782.2 87298.6 88541.1 11421.9 11608.9 11627.1 11630.9 11953.5 16863.9 16874.0 17007.3 17048.9 17066.1 8713.6 8869.6 8928.7 9106.9 9123.9 8892.0 8951.6 8955.7 8970.3 8983.4 5123.3 5137.6 5142.8 5178.7 5199.4 1881.3 2044.9 2047.4 2129.1 2156.7 1023.6 1065.8 1066.9 1087.8 1101.3 18347.6 18921.6 19113.7 19152.5 19927.7 1074.1 1088.5 1094.1 1111.5 1124.5 10662.8 10981.3 11004.3 11132.9 11152.8 516237.0 526449.0 551661.0 552918.0 557644.0 105997.5 110111.0 110144.4 110411.0 110839.4 1128.4 1143.4 1155.6 1195.2 1198.6 17332.7 17955.9 18026.9 18172.4 18493.9 39548.6 40473.2 40714.2 41112.4 41173.8 52616.0 53466.2 53475.7 53519.7 54116.7 8339.8 8446.9 8512.3 8521.3 8530.3 13099.9 13379.6 13403.7 13446.7 13516.7 11565.2 11615.9 11670.9 11915.5 12258.0 11402.5 11501.8 11667.8 11693.9 11741.5 9705.9 11568.2 12011.5 12040.8 12101.5 8376.3 8425.2 8534.3 8693.0 8733.5 10688.6 11350.8 11496.9 11501.5 11967.3 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | [#3] mootools.html Cycles:180 Average:5742.04 Median:4727.31 stddev:3189.92 (67.5%) stddev-sans-first:3182.08 03:49:58 INFO - PROCESS | 3415 | Values: 1388.0 1548.8 1568.0 1762.5 1863.9 7954.5 8079.0 8121.0 8140.1 8141.1 8197.5 8358.5 8371.9 8383.2 8395.1 2128.9 2167.4 2376.2 2424.4 2461.8 2445.6 2481.8 2486.5 2489.7 2491.5 2372.5 2406.5 2408.4 2426.7 2429.8 2077.5 2347.8 2402.4 2415.7 2426.2 2345.5 2357.5 2393.7 2399.5 2399.7 8185.8 8197.1 8237.8 8249.1 8258.8 5225.6 5358.2 5388.7 5390.6 5392.3 3397.8 3436.8 3489.0 3526.8 3574.7 1129.8 1144.4 1171.1 1191.5 1214.0 12335.3 12490.1 12529.7 12533.1 12555.4 4638.7 4667.9 4728.1 4756.6 4762.2 10733.1 10764.1 10766.7 10783.2 10788.2 5436.5 5471.0 5479.7 5481.3 5483.6 4228.2 4726.5 4746.2 4750.9 4803.8 4130.1 4142.2 4153.9 4181.9 4233.0 1346.4 1391.9 1411.4 1415.0 1424.3 1035.0 1038.9 1051.9 1063.4 1066.7 5997.6 6021.5 6051.2 6074.2 6263.1 448.7 449.5 450.8 454.4 455.3 4120.2 4301.7 4418.2 4498.1 4525.3 9987.2 10186.0 10229.1 10247.7 10257.7 10148.3 10157.4 10307.1 10309.5 10336.3 8407.5 8435.4 8529.4 8558.0 8560.1 6004.7 6151.8 6182.4 6203.2 6282.6 9674.2 9695.3 9757.5 9822.6 9940.3 9912.5 9968.0 10028.8 10189.2 10198.1 6773.0 6974.9 7325.1 7533.7 7694.7 8396.8 8398.4 8430.2 8459.0 8466.3 7441.5 7447.9 7469.3 7671.1 7689.1 7139.6 7160.6 7179.2 7246.1 7283.8 6901.2 6914.1 6965.7 6978.3 6981.3 5125.2 5130.7 5214.9 5316.5 5377.6 5254.0 5292.5 5399.0 5406.2 5408.6 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | [#4] prototype.html Cycles:180 Average:5493.11 Median:6331.51 stddev:1708.16 (27.0%) stddev-sans-first:1668.46 03:49:58 INFO - PROCESS | 3415 | Values: 332.6 334.5 337.6 341.4 343.7 6200.8 6256.8 6264.4 6301.9 6330.6 6165.6 6222.8 6235.8 6247.7 6248.8 4479.2 4554.8 4657.9 4659.7 4673.5 4661.2 4684.3 4685.1 4702.0 4710.6 4433.1 4658.5 4660.8 4668.3 4668.6 4548.5 4661.8 4662.3 4669.5 4681.1 4061.7 4063.5 4076.3 4077.2 4080.4 5943.4 5954.9 5955.2 5958.5 5967.1 5393.4 5424.5 5432.0 5432.7 5439.0 6503.4 6512.4 6516.1 6522.6 6523.1 4280.0 4393.9 4402.1 4407.3 4418.7 6704.5 6830.4 6851.5 6866.1 6867.8 4493.8 4512.0 4515.0 4518.4 4520.8 4567.1 4571.9 4573.5 4574.5 4575.4 5343.1 5344.5 5345.6 5349.0 5350.3 6420.2 6596.8 6609.3 6635.8 6643.0 1586.5 1600.5 1609.7 1609.8 1612.6 977.6 979.0 1023.7 1049.5 1049.5 6251.4 6330.1 6349.1 6352.3 6363.0 6754.5 6777.0 6783.8 6793.9 6867.3 6319.8 6332.4 6333.4 6337.2 6343.0 3627.1 3629.1 3654.9 3657.8 3664.7 6899.2 7158.0 7162.9 7176.0 7180.3 6994.5 7034.3 7042.4 7049.1 7052.9 6991.0 7024.3 7037.3 7044.0 7052.3 6859.1 6859.2 6865.6 6867.7 6879.8 6564.6 6768.5 6770.6 6776.3 6779.4 7137.4 7139.1 7145.9 7153.0 7157.6 4506.2 4527.8 4535.7 4554.6 4559.4 6848.7 6859.6 6861.2 6862.0 6869.9 6506.0 6644.2 6651.4 6661.3 6662.8 6600.6 6640.0 6646.7 6647.5 6666.4 6545.3 6547.4 6555.7 6556.2 6556.6 6724.4 6735.8 6777.6 6797.6 6806.0 6451.0 6550.4 6577.8 6578.0 6580.6 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - PROCESS | 3415 | [#5] yui.html Cycles:180 Average:15456.64 Median:5084.99 stddev:18132.31 (356.6%) stddev-sans-first:18150.00 03:49:58 INFO - PROCESS | 3415 | Values: 850.8 866.2 876.8 915.3 935.3 14231.9 14716.9 14845.1 14853.2 14938.3 13872.4 13887.3 13900.9 13942.0 13951.4 749.0 873.4 888.8 902.4 911.5 896.2 899.7 905.0 905.0 905.5 935.6 936.5 937.5 938.8 939.4 781.1 922.8 931.4 934.0 934.5 682.4 682.9 683.0 685.3 687.9 14604.9 14681.1 14684.9 14695.6 14709.8 14750.5 15083.8 15159.7 15168.4 15298.6 12097.7 12150.7 12162.9 12394.9 12440.9 4036.0 4042.9 4052.8 4185.6 4199.5 53758.7 53874.0 56548.0 56549.0 56607.4 10155.7 10324.0 10484.8 10629.9 10643.3 19837.3 19856.8 19861.0 20037.8 20547.9 8925.2 9035.2 9044.9 9060.0 9075.5 5004.0 5065.7 5104.3 5104.9 5209.6 3352.4 3387.2 3388.1 3389.8 3393.8 624.4 624.4 633.9 635.8 668.6 649.0 663.6 672.5 675.3 691.7 8393.1 8719.4 8780.6 8833.3 9239.2 649.3 670.4 675.7 681.2 684.0 4343.3 4461.4 4608.0 4617.4 4625.2 59700.7 62422.7 63797.4 64060.4 64245.0 59543.7 59569.4 60711.7 61451.7 61760.7 52489.7 52541.7 55153.2 55978.4 56434.2 8413.2 8502.1 8524.7 8872.2 9080.0 38084.6 38768.4 38934.2 39083.0 39721.0 44378.8 44521.3 47644.8 48041.3 55388.4 12370.6 12448.3 12624.8 12644.0 13119.1 12896.7 12979.7 13354.3 13454.3 13475.7 12194.4 12463.8 12663.6 12803.8 12809.6 12689.7 12795.4 12990.2 13059.6 13489.1 12649.7 12778.0 12832.1 13354.0 13376.8 10276.8 10424.8 10750.7 10830.2 11001.4 8951.7 9003.5 9124.2 9139.1 9146.4 03:49:58 INFO - PROCESS | 3415 | -------- Summary: end -------- 03:49:58 INFO - PROCESS | 3415 | 03:49:58 INFO - TEST-INFO | 3415: exit 0 03:49:58 INFO - TEST-OK | dromaeo_css | took 1113533ms 03:49:58 INFO - TEST-START | kraken 03:49:58 INFO - operating with platform_type : linux_ 03:49:58 INFO - Initialising browser for kraken test... 03:49:58 INFO - TEST-INFO | started process 3601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnBZsEt/profile http://localhost:42880/getInfo.html) 03:50:03 INFO - PROCESS | 3601 | __metrics Screen width/height:1600/1200 03:50:03 INFO - PROCESS | 3601 | colorDepth:24 03:50:03 INFO - PROCESS | 3601 | Browser inner width/height: 1024/697 03:50:03 INFO - PROCESS | 3601 | __metrics 03:50:04 ERROR - PROCESS | 3601 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:50:04 INFO - TEST-INFO | 3601: exit 0 03:50:04 INFO - Browser initialized. 03:50:04 INFO - Running cycle 1/1 for kraken test... 03:50:04 INFO - TEST-INFO | started process 3694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnBZsEt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:16 INFO - PROCESS | 3694 | RSS: Main: 141901824 03:50:16 INFO - PROCESS | 3694 | 03:50:19 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42880/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:20 INFO - PROCESS | 3694 | RSS: Main: 196399104 03:50:20 INFO - PROCESS | 3694 | 03:50:22 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42880/tests/kraken/driver.html?testName=audio-dft) 03:50:23 INFO - PROCESS | 3694 | RSS: Main: 182435840 03:50:23 INFO - PROCESS | 3694 | 03:50:26 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42880/tests/kraken/driver.html?testName=audio-fft) 03:50:26 INFO - PROCESS | 3694 | RSS: Main: 273494016 03:50:26 INFO - PROCESS | 3694 | 03:50:28 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42880/tests/kraken/driver.html?testName=audio-oscillator) 03:50:29 INFO - PROCESS | 3694 | RSS: Main: 179044352 03:50:29 INFO - PROCESS | 3694 | 03:50:31 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:32 INFO - PROCESS | 3694 | RSS: Main: 177922048 03:50:32 INFO - PROCESS | 3694 | 03:50:35 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42880/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:35 INFO - PROCESS | 3694 | RSS: Main: 212418560 03:50:35 INFO - PROCESS | 3694 | 03:50:38 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42880/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:39 INFO - PROCESS | 3694 | RSS: Main: 212426752 03:50:39 INFO - PROCESS | 3694 | 03:50:42 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42880/tests/kraken/driver.html?testName=json-parse-financial) 03:50:42 INFO - PROCESS | 3694 | RSS: Main: 212840448 03:50:42 INFO - PROCESS | 3694 | 03:50:44 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:45 INFO - PROCESS | 3694 | RSS: Main: 191860736 03:50:45 INFO - PROCESS | 3694 | 03:50:46 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:47 INFO - PROCESS | 3694 | RSS: Main: 196734976 03:50:47 INFO - PROCESS | 3694 | 03:50:49 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:49 INFO - PROCESS | 3694 | RSS: Main: 210190336 03:50:49 INFO - PROCESS | 3694 | 03:50:52 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:52 INFO - PROCESS | 3694 | RSS: Main: 213921792 03:50:52 INFO - PROCESS | 3694 | 03:50:55 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:56 INFO - PROCESS | 3694 | RSS: Main: 209469440 03:50:56 INFO - PROCESS | 3694 | 03:50:57 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:42880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42880/tests/kraken/driver.html?testName=ai-astar) 03:50:58 INFO - PROCESS | 3694 | RSS: Main: 273457152 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | __start_tp_report 03:50:58 INFO - PROCESS | 3694 | _x_x_mozilla_page_load 03:50:58 INFO - PROCESS | 3694 | _x_x_mozilla_page_load_details 03:50:58 INFO - PROCESS | 3694 | |i|pagename|runs| 03:50:58 INFO - PROCESS | 3694 | |0;ai-astar;110;110;111;112;110;109;105;111;111;108 03:50:58 INFO - PROCESS | 3694 | |1;audio-beat-detection;148;125;152;190;132;155;149;127;184;123 03:50:58 INFO - PROCESS | 3694 | |2;audio-dft;162;162;160;160;160;159;159;159;170;159 03:50:58 INFO - PROCESS | 3694 | |3;audio-fft;73;77;76;166;76;73;74;76;155;76 03:50:58 INFO - PROCESS | 3694 | |4;audio-oscillator;92;91;153;91;91;92;151;92;92;151 03:50:58 INFO - PROCESS | 3694 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 03:50:58 INFO - PROCESS | 3694 | |6;imaging-darkroom;145;146;145;146;146;145;146;145;146;146 03:50:58 INFO - PROCESS | 3694 | |7;imaging-desaturate;94;95;95;96;96;95;95;95;95;95 03:50:58 INFO - PROCESS | 3694 | |8;json-parse-financial;54;53;54;53;53;53;53;74;53;51 03:50:58 INFO - PROCESS | 3694 | |9;json-stringify-tinderbox;59;64;58;58;59;58;58;58;58;58 03:50:58 INFO - PROCESS | 3694 | |10;stanford-crypto-aes;72;72;72;72;73;72;73;73;75;73 03:50:58 INFO - PROCESS | 3694 | |11;stanford-crypto-ccm;116;117;121;116;114;113;119;115;140;122 03:50:58 INFO - PROCESS | 3694 | |12;stanford-crypto-pbkdf2;163;158;157;156;156;158;164;157;157;160 03:50:58 INFO - PROCESS | 3694 | |13;stanford-crypto-sha256-iterative;66;67;65;71;64;69;66;67;66;64 03:50:58 INFO - PROCESS | 3694 | __end_tp_report 03:50:58 INFO - PROCESS | 3694 | __start_cc_report 03:50:58 INFO - PROCESS | 3694 | _x_x_mozilla_cycle_collect,1588 03:50:58 INFO - PROCESS | 3694 | __end_cc_report 03:50:58 INFO - PROCESS | 3694 | __startTimestamp1463568658196__endTimestamp 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | ------- Summary: start ------- 03:50:58 INFO - PROCESS | 3694 | Number of tests: 14 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.00 (1.8%) stddev-sans-first:2.12 03:50:58 INFO - PROCESS | 3694 | Values: 110.0 110.0 111.0 112.0 110.0 109.0 105.0 111.0 111.0 108.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:150.50 stddev:23.51 (15.6%) stddev-sans-first:24.94 03:50:58 INFO - PROCESS | 3694 | Values: 148.0 125.0 152.0 190.0 132.0 155.0 149.0 127.0 184.0 123.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#2] audio-dft Cycles:10 Average:161.00 Median:160.00 stddev:3.37 (2.1%) stddev-sans-first:3.55 03:50:58 INFO - PROCESS | 3694 | Values: 162.0 162.0 160.0 160.0 160.0 159.0 159.0 159.0 170.0 159.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:36.12 (47.5%) stddev-sans-first:37.63 03:50:58 INFO - PROCESS | 3694 | Values: 73.0 77.0 76.0 166.0 76.0 73.0 74.0 76.0 155.0 76.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:91.50 stddev:29.04 (31.7%) stddev-sans-first:30.09 03:50:58 INFO - PROCESS | 3694 | Values: 92.0 91.0 153.0 91.0 91.0 92.0 151.0 92.0 92.0 151.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:50:58 INFO - PROCESS | 3694 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:50:58 INFO - PROCESS | 3694 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 03:50:58 INFO - PROCESS | 3694 | Values: 94.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:53.00 stddev:6.69 (12.6%) stddev-sans-first:7.08 03:50:58 INFO - PROCESS | 3694 | Values: 54.0 53.0 54.0 53.0 53.0 53.0 53.0 74.0 53.0 51.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.00 stddev:1.87 (3.2%) stddev-sans-first:1.99 03:50:58 INFO - PROCESS | 3694 | Values: 59.0 64.0 58.0 58.0 59.0 58.0 58.0 58.0 58.0 58.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:0.95 (1.3%) stddev-sans-first:0.97 03:50:58 INFO - PROCESS | 3694 | Values: 72.0 72.0 72.0 72.0 73.0 72.0 73.0 73.0 75.0 73.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:118.00 stddev:7.83 (6.6%) stddev-sans-first:8.22 03:50:58 INFO - PROCESS | 3694 | Values: 116.0 117.0 121.0 116.0 114.0 113.0 119.0 115.0 140.0 122.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.00 stddev:2.84 (1.8%) stddev-sans-first:2.52 03:50:58 INFO - PROCESS | 3694 | Values: 163.0 158.0 157.0 156.0 156.0 158.0 164.0 157.0 157.0 160.0 03:50:58 INFO - PROCESS | 3694 | 03:50:58 INFO - PROCESS | 3694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:2.17 (3.3%) stddev-sans-first:2.30 03:50:58 INFO - PROCESS | 3694 | Values: 66.0 67.0 65.0 71.0 64.0 69.0 66.0 67.0 66.0 64.0 03:50:58 INFO - PROCESS | 3694 | -------- Summary: end -------- 03:50:58 INFO - PROCESS | 3694 | 03:51:00 INFO - TEST-INFO | 3694: exit 0 03:51:00 INFO - TEST-OK | kraken | took 61410ms 03:51:00 INFO - SUITE-END | took 1174s 03:51:00 INFO - Completed test suite (00:19:34) 03:51:00 INFO - javascript benchmark 03:51:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3257.299680568678, 3311.850966706498, 3340.816255105969, 3357.3956687796217, 3373.3421982713367, 5415.891682166354, 5434.538064264542, 5436.700981446019, 5448.3734370547345, 5465.262189604402, 5455.972720136394, 5463.7814487420455, 5471.06991811392, 5475.315585551806, 5496.560275177986, 4771.761411929407, 4850.951490485103, 4925.581325587329, 4995.65030447867, 5051.898962020776, 4862.708237505761, 4884.145274576953, 4901.338319326881, 4907.2148456247005, 4907.75461226939, 4922.80308787648, 4974.801007959677, 4995.850124496253, 5004.474530174334, 5020.0963826511215, 5051.570616497602, 5069.974650126745, 5071.695698258116, 5074.112030394666, 5079.03498335317, 4812.446568644581, 4829.082474329901, 4875.634327425457, 4967.254911763264, 5006.998600279922, 5426.321709786277, 5450.482204190595, 5474.562035037187, 5489.478499542577, 5496.945030549683, 5918.141869428951, 5952.077427998667, 5952.7023648817385, 5952.7321270542925, 5953.315368732608, 5931.822045338647, 5950.9702451487465, 5961.850953726148, 6007.849803754897, 6020.518358531351, 5447.509724124809, 5453.127499600045, 5457.890842183174, 5476.342838859323, 5479.0, 5815.156802263733, 5921.96365636012, 5923.49650279731, 5929.3181284152015, 5931.199288096138, 5704.857378565486, 5752.654840709487, 5758.74085666146, 5766.192733017381, 5816.88366232673, 5756.0, 5773.076307790818, 5776.624519406225, 5779.248697669276, 5790.160426738099, 5606.747696353674, 5741.684207368635, 5747.339056008529, 5751.798687046017, 5758.0, 5756.481916627524, 5758.452946970031, 5759.1937128802, 5793.652380857162, 5799.739011744482, 4293.957060429419, 4297.763623000703, 4309.913801723948, 4311.6335111515245, 4331.566843315706, 3816.790076545761, 3850.2299540092095, 3912.39357899526, 3917.7061720371084, 3936.3308237599676, 5519.144532597454, 5529.391766905637, 5534.501894829485, 5546.251256080377, 5568.16477528374, 5873.882522349614, 5880.588358814842, 5883.352831188566, 5890.175375447441, 5891.263592050994, 5388.7305634718105, 5552.52803511706, 5646.661200327993, 5701.315842098975, 5706.514946229534, 4834.685745426536, 4860.3195552622665, 4862.5380588844, 4866.221404575251, 4894.583960363338, 5974.253218347707, 5984.850378740566, 5987.1318658794235, 5987.9101813472835, 6000.069989151689, 5736.082226843685, 5889.175515427758, 5964.165016897551, 5973.49225315853, 5993.310769261417, 6049.727762250797, 6062.272527296753, 6065.150878877049, 6072.180255665606, 6077.058056001327, 5750.654960702372, 5754.827355179351, 5757.107648314518, 5757.395473475225, 5759.94240057594, 5726.570507212059, 5886.23478947734, 5952.702364881652, 5956.76172953077, 5989.460948514655, 5700.230468886647, 5703.0, 5704.3154821421695, 5710.5717071219, 5712.057510510886, 5617.466340697627, 5650.886982260414, 5701.743421545957, 5706.058500347396, 5715.085586306171, 5625.971870140623, 5639.210510528447, 5672.60291779588, 5694.0, 5706.28671416073, 5723.255976723, 5743.56923230751, 5754.539636829128, 5758.769649213985, 5788.450097240755, 5462.863428414322, 5624.3250809903075, 5678.4605462480995, 5685.800996965252, 5689.800856969986], "value": 5380.475866492326, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.4583951523872, 661.0843981086196, 664.2029564522568, 665.3246954341342, 676.2223443040502, 33934.321313573746, 34604.65395346046, 34713.65286347139, 34864.651353486486, 34889.12777180572, 35035.29929401417, 35711.642883571156, 42175.0, 42566.57433425665, 42681.57318426815, 8877.866831997526, 9006.639734410648, 9022.684206052789, 9028.77428064297, 9033.09669033098, 8805.779855503599, 8998.730038098867, 9005.234555062827, 9009.099090091004, 9009.909900900973, 8402.915970840275, 8720.34597405194, 10940.671779846578, 11248.15638827087, 11260.155488338367, 10671.612690350243, 10748.247622666417, 10762.192835537287, 10782.353058816496, 10786.08318292946, 8341.41610087294, 10509.264351495398, 10619.30974486656, 10623.20325975555, 10628.681139565826, 40410.59589404098, 40712.185756285005, 40740.185196295904, 40766.388504172464, 40813.591864081274, 3937.7243592948507, 4061.97969010156, 4189.413482112506, 4387.94689274575, 4494.359747031186, 34605.82697086524, 34821.30357392838, 34902.476462853076, 35092.649073509194, 35122.0, 4551.180787458289, 4606.286025666027, 4609.815607375701, 4617.953820461786, 4646.372739680134, 323726.0, 326105.0, 326121.9999999976, 326233.0, 326460.0, 60874.39125608776, 68563.31436685669, 69215.0, 69405.0, 71111.64444177746, 67460.32539674638, 68063.0, 68167.0, 68204.31795682079, 68224.0, 18813.341533046278, 18835.152418140944, 19003.0, 19027.14377853, 19033.524161896064, 14854.405823767145, 14935.25323733809, 14959.850401495845, 14960.40158393652, 14972.550823475312, 19036.0, 20572.79427205739, 20791.58416831685, 21022.579548408947, 21599.0, 7664.31021208094, 7923.7226697065325, 7978.760637180894, 7981.281684648409, 8057.952466179359, 1156.803343431602, 1181.6218809980896, 1188.423614546944, 1218.6283183629077, 1277.7125146842072, 34506.96139657243, 34971.30057398838, 35102.824485877914, 35174.82412587972, 35784.0, 1209.2744353388073, 1241.422738426636, 1250.6748245456247, 1328.88373766037, 1355.213975893979, 18077.457676269732, 18163.45509634713, 18445.90777046106, 18492.35276765307, 18528.0, 221417.0, 222818.0, 223301.0, 223499.0, 223580.0, 63772.36227637757, 65107.67446162834, 65147.348526515074, 65152.34847651557, 65452.0, 1373.1006190944947, 1465.8754005909404, 1507.5376884422094, 1521.4598817420099, 1612.8225895151525, 30345.848270758506, 32589.511157333134, 32754.67245327516, 33877.83061084679, 33959.19670062719, 51230.23154652608, 51695.741521292155, 51809.0, 51855.481445186575, 51879.740601296755, 306008.0, 306306.0, 307243.0, 307708.0, 309167.0, 40314.798426007685, 46011.22563931987, 46688.29967550557, 50816.0, 51229.0, 49885.25172122494, 50262.0, 51179.744101279255, 53370.0, 56229.437705624056, 40567.0, 42062.57937420709, 42457.57542424536, 42677.35983960181, 42856.57143428526, 41770.164596708506, 42131.39383326505, 42365.36451953161, 42551.574484254765, 42557.148857023305, 44805.77597111993, 45081.549184507734, 45447.545524545654, 45846.77076614596, 45935.0, 33324.257560530816, 37919.62080379271, 38186.618133819415, 38351.42472862853, 38722.80638596789, 29183.270418239714, 29485.447684937957, 29549.852250738608, 29551.408971820012, 30110.397792043597], "value": 20962.774533825617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.5500114877083, 420.730732331308, 427.2715020889382, 427.730529766247, 436.90169711814843, 18910.243590256392, 19484.318048868292, 19495.41513754588, 19810.10854511547, 20740.170393184293, 18568.16443260053, 18913.338033168842, 20407.59184816303, 20429.795702042975, 20447.795522044777, 5019.247112933052, 5038.445770965191, 5228.79084836606, 5254.106801843695, 5254.842354729364, 4005.1989602079557, 5228.895422091556, 5232.2674825524455, 5420.268263784378, 5715.0, 5677.716114194273, 5704.629199102066, 5707.315122185343, 5711.428857114276, 5737.913931291034, 5357.43746906577, 5591.776328946838, 5604.915926261109, 5702.173184888189, 5706.77172913083, 3870.845166193349, 5281.86795330116, 5509.559235261169, 5515.917261241085, 5525.889482210374, 13139.671508212276, 13218.867811321956, 17878.642427151513, 22182.112715491523, 22183.11267549296, 2284.22972196549, 2360.091364824555, 2408.6146216605257, 2517.471331020488, 2937.8531073446243, 9917.553710083064, 10036.29745917786, 10045.14616257619, 10102.040306170902, 10428.843567346496, 1830.9542261443437, 1985.553250518636, 2009.1159889648654, 2035.236786205173, 2059.52630894895, 78418.60790696066, 80325.99999999942, 84782.15217847805, 87298.5635071827, 88541.11458885393, 11421.942890285496, 11608.883911160949, 11627.12796540263, 11630.941845290889, 11953.46209420578, 16863.91568042152, 16874.0, 17007.31970721182, 17048.914755426144, 17066.146692665316, 8713.564321783886, 8869.600867960957, 8928.687495937611, 9106.86339704905, 9123.863142052875, 8892.0, 8951.641934322684, 8955.686550970684, 8970.282377409792, 8983.371164018587, 5123.308353372322, 5137.640365174402, 5142.820001299937, 5178.689278643218, 5199.402068762065, 1881.2851116575614, 2044.877307361563, 2047.396018174642, 2129.052571605652, 2156.6872803443725, 1023.5505898805314, 1065.79217052674, 1066.893310668927, 1087.8259478483405, 1101.3061771084165, 18347.63304733898, 18921.62156756857, 19113.713294300596, 19152.52118697016, 19927.701084483746, 1074.1245884604023, 1088.450332582041, 1094.1192340166242, 1111.5276007696696, 1124.4658787076073, 10662.786744265226, 10981.341119532854, 11004.284721493077, 11132.886711328802, 11152.832707509393, 516237.0, 526449.0, 551661.0, 552918.0, 557644.0, 105997.47001264944, 110111.0, 110144.4492777531, 110411.0, 110839.44580277208, 1128.3963079752293, 1143.3654321851286, 1155.641751057175, 1195.2171327780318, 1198.6404078776332, 17332.653346933243, 17955.910220448815, 18026.90986545059, 18172.36396726108, 18493.9075304628, 39548.604513954495, 40473.1905361897, 40714.18571628492, 41112.44263004257, 41173.79413102915, 52616.0, 53466.19800702915, 53475.73262133665, 53519.732401337744, 54116.72941635267, 8339.791505212419, 8446.915530844859, 8512.276456501018, 8521.318294536546, 8530.317574593893, 13099.934500327437, 13379.598612041655, 13403.664908377368, 13446.663833404244, 13516.662083447993, 11565.248258863146, 11615.88384116148, 11670.88329116698, 11915.52337906474, 12257.958073563846, 11402.48688808989, 11501.769964600828, 11667.766644667228, 11693.941530292293, 11741.471633776671, 9705.854412183682, 11568.190226684052, 12011.459484323052, 12040.819387709016, 12101.515939362327, 8376.329893608376, 8425.199606037417, 8534.274586660204, 8692.956535217283, 8733.519656418704, 10688.57245710194, 11350.772984540428, 11496.88503114958, 11501.539938402704, 11967.281963082243], "value": 9390.823820664187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.0, 1548.8141423029238, 1568.0199875078076, 1762.51530829022, 1863.9440816775502, 7954.482958607694, 8078.990126234221, 8120.959395203023, 8140.1452847451055, 8141.06377766557, 8197.508149511033, 8358.498490090598, 8371.91628083719, 8383.203595658402, 8395.118512556186, 2128.88291143987, 2167.4039639099296, 2376.227725989052, 2424.369663887389, 2461.7661322174454, 2445.6209287560455, 2481.813863960201, 2486.477839653675, 2489.73857744936, 2491.5141547398266, 2372.50177462733, 2406.4946361264156, 2408.4460574067975, 2426.672399226108, 2429.8056155507516, 2077.4910147014, 2347.7534858839917, 2402.3753824005707, 2415.6738840256517, 2426.162973774045, 2345.4839935214227, 2357.4931389751287, 2393.7366889642126, 2399.5320912422085, 2399.748026457214, 8185.836283274301, 8197.0573384061, 8237.83524329516, 8249.133840946733, 8258.843761873342, 5225.581953443715, 5358.169483730028, 5388.73056347185, 5390.649607775482, 5392.299001129828, 3397.8470968806214, 3436.8453419596176, 3488.982555087234, 3526.770759900598, 3574.7318951078514, 1129.807932651443, 1144.3877525523887, 1171.1275100050432, 1191.53530123252, 1214.0409076829294, 12335.259884406963, 12490.12569120171, 12529.686757831036, 12533.060020498408, 12555.435005424777, 4638.6752927294765, 4667.879708869915, 4728.1252968201, 4756.6432517561325, 4762.238041913277, 10733.141348692086, 10764.085052770446, 10766.676999690022, 10783.245172837826, 10788.244822862482, 5436.510714035756, 5471.0, 5479.698616576126, 5481.314835645544, 5483.643563168382, 4228.23891699497, 4726.503717109723, 4746.169420351424, 4750.928736068961, 4803.759812009455, 4130.112025914383, 4142.171565686875, 4153.896152596149, 4181.916361672749, 4233.026403927052, 1346.3604787725947, 1391.9234442105578, 1411.4283715095403, 1414.985850141506, 1424.273620453576, 1034.9586016559404, 1038.948052597367, 1051.8790339111101, 1063.42575009494, 1066.6799960011965, 5997.640141591519, 6021.458068773832, 6051.213342265565, 6074.240719910012, 6263.091851681481, 448.7038554554044, 449.49656384848527, 450.8264318237502, 454.42969073812156, 455.2533844495031, 4120.196561670446, 4301.741895486281, 4418.248897687401, 4498.122866041091, 4525.321201819754, 9987.201023918069, 10186.0, 10229.07938285543, 10247.692569222936, 10257.743556411, 10148.340357876714, 10157.441340726331, 10307.072363487323, 10309.484525773682, 10336.276460647683, 8407.495550267004, 8435.409521333448, 8529.360297977677, 8558.0, 8560.101189375151, 6004.729787159501, 6151.784687536094, 6182.443580077635, 6203.16257305258, 6282.623042617458, 9674.226061915171, 9695.272854536079, 9757.46333951611, 9822.557984890555, 9940.304178707422, 9912.454814985245, 9968.0, 10028.849567256351, 10189.235807314333, 10198.082172604501, 6772.966135169293, 6974.930250697631, 7325.084364454443, 7533.698652053857, 7694.730684426018, 8396.790080247798, 8398.370122240978, 8430.15698430152, 8459.0, 8466.322694184328, 7441.479096463412, 7447.851042979001, 7469.327354703861, 7671.07947046358, 7689.115751688628, 7139.643017849191, 7160.57036577807, 7179.174394944648, 7246.130464344313, 7283.817904552428, 6901.206361268318, 6914.0666010088, 6965.721371145098, 6978.267281935324, 6981.301869812978, 5125.205593133071, 5130.666026833125, 5214.921776173436, 5316.521513063843, 5377.596680249075, 5254.0, 5292.497212764782, 5399.028174928393, 5406.216098665593, 5408.567314614743], "value": 4581.423274791752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.6158287178308, 334.5400074897017, 337.59825807289315, 341.42469938154227, 343.66664335594464, 6200.751969921203, 6256.84357891053, 6264.373562643734, 6301.936980630192, 6330.588511746739, 6165.564601982225, 6222.782202622898, 6235.844103897405, 6247.687615619212, 6248.812535623927, 4479.216137175998, 4554.817807287704, 4657.930131048037, 4659.673822832403, 4673.532646735316, 4661.230896902007, 4684.344191813132, 4685.109829132471, 4701.976490117545, 4710.599599034086, 4433.113377324532, 4658.487566367714, 4660.813567457298, 4668.276417155346, 4668.603168730645, 4548.454185497745, 4661.81352745888, 4662.347271382009, 4669.533046695304, 4681.063787242531, 4061.6547593454593, 4063.4920634920636, 4076.286649836267, 4077.1845630873945, 4080.4287399764057, 5943.3759455257, 5954.8809023819285, 5955.225820643332, 5958.463738263534, 5967.1347654589845, 5393.4336894626285, 5424.484673955968, 5432.049391356497, 5432.674039557639, 5439.0209762242785, 6503.382178693017, 6512.446442052431, 6516.055172000081, 6522.608643481359, 6523.119378883837, 4279.957200427987, 4393.890152746175, 4402.053558484941, 4407.250767369523, 4418.734875907456, 6704.463642908604, 6830.351116643911, 6851.520393572452, 6866.107406037283, 6867.828304292383, 4493.775311234425, 4511.954880451219, 4515.029268707243, 4518.390017347681, 4520.796564154621, 4567.109413664303, 4571.862844114682, 4573.5426457354, 4574.45106587205, 4575.405197324393, 5343.091674415358, 5344.545713614309, 5345.572354211654, 5348.973255133699, 5350.3312085989255, 6420.165378500765, 6596.80209593713, 6609.306022867626, 6635.767748128792, 6642.96678516614, 1586.476462767284, 1600.4558450127013, 1609.7263465210942, 1609.8148712897932, 1612.5807290104422, 977.5552123783662, 978.9951050244703, 1023.65195833417, 1049.5014867937668, 1049.5277125293649, 6251.374862513712, 6330.082138090043, 6349.079383489368, 6352.2694890087305, 6363.0, 6754.45964322853, 6777.0, 6783.830404239933, 6793.932060679429, 6867.3476019778045, 6319.778807741799, 6332.430081292614, 6333.398327158912, 6337.176167098248, 6343.0485427186295, 3627.147620309225, 3629.1108678373967, 3654.8903532893523, 3657.8112113563197, 3664.72514561409, 6899.206591241971, 7158.0, 7162.892556611655, 7175.964120179366, 7180.31786980236, 6994.545354551938, 7034.2965703429245, 7042.436605071582, 7049.118860142482, 7052.929470705228, 6990.965045174741, 7024.262452442522, 7037.296270372922, 7044.049053377831, 7052.259512751088, 6859.142607174103, 6859.211190713132, 6865.622390768555, 6867.725290988305, 6879.828004299732, 6564.6389448578875, 6768.4585233182215, 6770.5599136056, 6776.322367763184, 6779.423748981392, 7137.393321567725, 7139.107611548557, 7145.85708285821, 7152.964235178791, 7157.57054576727, 4506.233940230103, 4527.796249168729, 4535.659825513034, 4554.567316104964, 4559.430071241095, 6848.657567121524, 6859.588424694534, 6861.245263020964, 6861.965690171517, 6869.931300687129, 6506.0, 6644.169478815148, 6651.368120028589, 6661.3338666132995, 6662.83342916431, 6600.60396376219, 6640.0, 6646.734130634721, 6647.534672573067, 6666.400023997863, 6545.345465453607, 6547.443467305142, 6555.704993275219, 6556.213254409501, 6556.5738227017, 6724.361185687352, 6735.831604209934, 6777.6272305023695, 6797.592144471348, 6806.047153398627, 6450.967745161244, 6550.410463058348, 6577.80266592003, 6578.0, 6580.605163690194], "value": 4926.239319848957, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.7745447456422, 866.246365661874, 876.8071024374635, 915.2702736349376, 935.2658163341778, 14231.92884035581, 14716.852831471695, 14845.109293442401, 14853.183074930874, 14938.327775250113, 13872.37574309156, 13887.305634718248, 13900.860991390084, 13942.0, 13951.441942322295, 748.962551872407, 873.4060838629729, 888.835565420396, 902.4224496322358, 911.5077857956728, 896.224765577777, 899.6941040046383, 904.9864252036225, 905.0225756183339, 905.4612505559181, 935.5836652689555, 936.494293081735, 937.4515908193681, 938.8497840345547, 939.3940908114262, 781.0978320040363, 922.7739203895021, 931.417863835103, 934.042606328512, 934.5467448287575, 682.4199430484049, 682.9112215412015, 682.9795106146773, 685.348918527401, 687.8521117959613, 14604.853951460456, 14681.119132852064, 14684.898632602597, 14695.63260918475, 14709.779353309601, 14750.483733069292, 15083.773743393858, 15159.696806063926, 15168.393264269416, 15298.617534561614, 12097.684644179933, 12150.696232594168, 12162.878371216262, 12394.938025309906, 12440.875591244063, 4035.959640403588, 4042.898927526806, 4052.817623206933, 4185.560516145822, 4199.496060472732, 53758.73120634372, 53873.99999999961, 56548.0, 56549.0, 56607.433925660625, 10155.695329140137, 10324.0, 10484.842727359095, 10629.946850265855, 10643.308184968108, 19837.30569430063, 19856.801431985783, 19861.0, 20037.799622003884, 20547.897260513902, 8925.152110549487, 9035.232005279493, 9044.8643270351, 9059.954700226457, 9075.50084745332, 5004.0, 5065.721385323843, 5104.259882317043, 5104.872378190575, 5209.583233341324, 3352.4133276676484, 3387.2209391840015, 3388.102152929476, 3389.7966122032262, 3393.8472768725464, 624.4036944717784, 624.4036944717784, 633.8542135308904, 635.7520566978882, 668.5721138471382, 648.9870202595922, 663.5620490476263, 672.5191488086042, 675.2909445082644, 691.7371398868398, 8393.06025341107, 8719.389642725075, 8780.604872780612, 8833.293336533063, 9239.195260625878, 649.331188875459, 670.4368330602219, 675.7026908160394, 681.2302098628518, 683.9760608378683, 4343.348497725303, 4461.353103799996, 4607.976960115245, 4617.39842922521, 4625.236835922103, 59700.70149649224, 62422.68788656028, 63797.36202638007, 64060.35939640544, 64245.0, 59543.70228148832, 59569.40430595725, 60711.69644151839, 61451.6927415369, 61760.69119654373, 52489.737551312, 52541.737291314064, 55153.172702409494, 55978.44021559732, 56434.15348769772, 8413.158684131538, 8502.107278735892, 8524.70163544273, 8872.24585910205, 9080.0, 38084.619153808104, 38768.41847372348, 38934.22131557296, 39083.0, 39721.0, 44378.77810610926, 44521.33218001668, 47644.7617761909, 48041.27938081002, 55388.44611553994, 12370.62888113358, 12448.25310481374, 12624.810627840774, 12644.0, 13119.147255428366, 12896.684680005374, 12979.740405192033, 13354.265515396746, 13454.26001569884, 13475.663108422368, 12194.390280485763, 12463.750724985632, 12663.620091397273, 12803.80794288105, 12809.551665691655, 12689.682757930756, 12795.360231988177, 12990.155639883378, 13059.608211753663, 13489.123206991515, 12649.683757906127, 12778.0, 12832.101752877208, 13354.0, 13376.799348009594, 10276.794464110826, 10424.843627345748, 10750.677479675622, 10830.241883068109, 11001.394923278976, 8951.73144805657, 9003.459792412476, 9124.224440922597, 9139.086091391073, 9146.405483643543], "value": 6964.474320477386, "unit": "score"}], "name": "dromaeo_css", "value": 7417.1406165760545, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 112.0, 110.0, 109.0, 105.0, 111.0, 111.0, 108.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 152.0, 190.0, 132.0, 155.0, 149.0, 127.0, 184.0, 123.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 160.0, 160.0, 159.0, 159.0, 159.0, 170.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 76.0, 166.0, 76.0, 73.0, 74.0, 76.0, 155.0, 76.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 153.0, 91.0, 91.0, 92.0, 151.0, 92.0, 92.0, 151.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 74.0, 53.0, 51.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 72.0, 73.0, 73.0, 75.0, 73.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 121.0, 116.0, 114.0, 113.0, 119.0, 115.0, 140.0, 122.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 157.0, 156.0, 156.0, 158.0, 164.0, 157.0, 157.0, 160.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 71.0, 64.0, 69.0, 66.0, 67.0, 66.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1509.4999999999998, "alertThreshold": 2.0}]} 03:51:00 INFO - Return code: 0 03:51:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:51:00 ERROR - # TBPL SUCCESS # 03:51:00 INFO - Running post-action listener: _resource_record_post_action 03:51:00 INFO - Running post-run listener: _resource_record_post_run 03:51:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 419463168; Read time: 1044; Write time: 367160 03:51:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7544832; Read time: 0; Write time: 624 03:51:01 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6074368; Write bytes: 409952256; Read time: 1012; Write time: 362872 03:51:01 INFO - Running post-run listener: _upload_blobber_files 03:51:01 INFO - Blob upload gear active. 03:51:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:01 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 03:51:01 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:01 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:02 INFO - (blobuploader) - INFO - Done attempting. 03:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:03 INFO - (blobuploader) - INFO - Done attempting. 03:51:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:03 INFO - Return code: 0 03:51:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16097560c8f6ad65a75a7c9b51c5e8fae2e6d726924af8e2ef878458061497df81ba4a30ea531f6f75510b380d3ff5c2cfea1aeebc9301e87b436f736c8d59a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0cff15561257f0e15c58c4321bc37f723cae49fbf53080572efd1a2ae0f5b4575ed387e111d41498a15115eefb8e511ec94bf25e17f8b2158de88d6654c8087"} 03:51:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:03 INFO - Contents: 03:51:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16097560c8f6ad65a75a7c9b51c5e8fae2e6d726924af8e2ef878458061497df81ba4a30ea531f6f75510b380d3ff5c2cfea1aeebc9301e87b436f736c8d59a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0cff15561257f0e15c58c4321bc37f723cae49fbf53080572efd1a2ae0f5b4575ed387e111d41498a15115eefb8e511ec94bf25e17f8b2158de88d6654c8087"} 03:51:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:03 INFO - Copying logs to upload dir... 03:51:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.488623 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-18 03:51:03.551602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 03:51:03.554900) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16097560c8f6ad65a75a7c9b51c5e8fae2e6d726924af8e2ef878458061497df81ba4a30ea531f6f75510b380d3ff5c2cfea1aeebc9301e87b436f736c8d59a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0cff15561257f0e15c58c4321bc37f723cae49fbf53080572efd1a2ae0f5b4575ed387e111d41498a15115eefb8e511ec94bf25e17f8b2158de88d6654c8087"} build_url:https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/D0JrVH-fSeaoINksJBUCUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16097560c8f6ad65a75a7c9b51c5e8fae2e6d726924af8e2ef878458061497df81ba4a30ea531f6f75510b380d3ff5c2cfea1aeebc9301e87b436f736c8d59a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0cff15561257f0e15c58c4321bc37f723cae49fbf53080572efd1a2ae0f5b4575ed387e111d41498a15115eefb8e511ec94bf25e17f8b2158de88d6654c8087"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 03:51:03.578956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:51:03.579279) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463567193.556049-1544335595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 03:51:03.662497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 03:51:03.662832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 03:51:03.663132) ========= ========= Total master_lag: 0.19 =========