builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1466503466.59 results: success (0) buildid: 20160621002003 builduid: 553f73d9ebe6486394dd8017761d8f1e revision: bef93a95add04ae173138d8391603bf77f9ae666 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.593496) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.594025) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.594442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.610081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.610392) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 03:04:26-- 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% 224M=0s 2016-06-21 03:04:26 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.749221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.749567) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015182 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.799906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:26.800306) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bef93a95add04ae173138d8391603bf77f9ae666 --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-beta --rev bef93a95add04ae173138d8391603bf77f9ae666 --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=9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 03:04:26,823 truncating revision to first 12 chars 2016-06-21 03:04:26,823 Setting DEBUG logging. 2016-06-21 03:04:26,823 attempt 1/10 2016-06-21 03:04:26,823 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bef93a95add0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 03:04:27,136 unpacking tar archive at: mozilla-beta-bef93a95add0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:27.468240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:27.468560) ========= script_repo_revision: bef93a95add04ae173138d8391603bf77f9ae666 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:27.468942) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:27.469239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 03:04:27.480180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-21 03:04:27.480463) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:27 INFO - MultiFileLogger online at 20160621 03:04:27 in /builds/slave/test 03:04:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:04:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:27 INFO - {'append_to_log': False, 03:04:27 INFO - 'base_work_dir': '/builds/slave/test', 03:04:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:04:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:27 INFO - 'branch': 'Mozilla-Beta', 03:04:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:27 INFO - 'config_files': ('talos/linux_config.py',), 03:04:27 INFO - 'default_actions': ('clobber', 03:04:27 INFO - 'read-buildbot-config', 03:04:27 INFO - 'download-and-extract', 03:04:27 INFO - 'populate-webroot', 03:04:27 INFO - 'create-virtualenv', 03:04:27 INFO - 'install', 03:04:27 INFO - 'run-tests'), 03:04:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:27 INFO - 'download_minidump_stackwalk': True, 03:04:27 INFO - 'download_symbols': 'ondemand', 03:04:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:27 INFO - 'installer_path': 'installer.exe', 03:04:27 INFO - 'log_level': 'info', 03:04:27 INFO - 'log_name': 'talos', 03:04:27 INFO - 'log_to_console': True, 03:04:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:27 INFO - 'opt_config_files': (), 03:04:27 INFO - 'pip_index': False, 03:04:27 INFO - 'sps_profile': False, 03:04:27 INFO - 'sps_profile_interval': 0, 03:04:27 INFO - 'suite': 'dromaeojs', 03:04:27 INFO - 'system_bits': '32', 03:04:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:27 INFO - 'title': 'talos-linux64-ix-040', 03:04:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:27 INFO - 'use_talos_json': True, 03:04:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:27 INFO - 'work_dir': 'build'} 03:04:27 INFO - ##### 03:04:27 INFO - ##### Running clobber step. 03:04:27 INFO - ##### 03:04:27 INFO - Running pre-action listener: _resource_record_pre_action 03:04:27 INFO - Running main action method: clobber 03:04:27 INFO - rmtree: /builds/slave/test/build 03:04:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:28 INFO - Running post-action listener: _resource_record_post_action 03:04:28 INFO - ##### 03:04:28 INFO - ##### Running read-buildbot-config step. 03:04:28 INFO - ##### 03:04:28 INFO - Running pre-action listener: _resource_record_pre_action 03:04:28 INFO - Running main action method: read_buildbot_config 03:04:28 INFO - Using buildbot properties: 03:04:28 INFO - { 03:04:28 INFO - "project": "", 03:04:28 INFO - "product": "firefox", 03:04:28 INFO - "script_repo_revision": "production", 03:04:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:04:28 INFO - "repository": "", 03:04:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:04:28 INFO - "buildid": "20160621002003", 03:04:28 INFO - "pgo_build": "True", 03:04:28 INFO - "basedir": "/builds/slave/test", 03:04:28 INFO - "buildnumber": 50, 03:04:28 INFO - "slavename": "talos-linux64-ix-040", 03:04:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:04:28 INFO - "platform": "ubuntu64_hw", 03:04:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:04:28 INFO - "branch": "mozilla-beta", 03:04:28 INFO - "repo_path": "releases/mozilla-beta", 03:04:28 INFO - "revision": "bef93a95add04ae173138d8391603bf77f9ae666", 03:04:28 INFO - "stage_platform": "linux64-pgo", 03:04:28 INFO - "builduid": "553f73d9ebe6486394dd8017761d8f1e", 03:04:28 INFO - "slavebuilddir": "test" 03:04:28 INFO - } 03:04:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 03:04:28 INFO - Running post-action listener: _resource_record_post_action 03:04:28 INFO - ##### 03:04:28 INFO - ##### Running download-and-extract step. 03:04:28 INFO - ##### 03:04:28 INFO - Running pre-action listener: _resource_record_pre_action 03:04:28 INFO - Running main action method: download_and_extract 03:04:28 INFO - mkdir: /builds/slave/test/build/tests 03:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:28 INFO - https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:04:29 INFO - Downloaded 1327 bytes. 03:04:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:04:29 INFO - Using the following test package requirements: 03:04:29 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:04:29 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:04:29 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 03:04:29 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'jsshell-linux-x86_64.zip'], 03:04:29 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:04:29 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:04:29 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 03:04:29 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 03:04:29 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:04:29 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:04:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:29 INFO - https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:30 INFO - Downloaded 24186188 bytes. 03:04:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:04:31 INFO - Return code: 0 03:04:31 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:31 INFO - https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:42 INFO - Downloaded 24186188 bytes. 03:04:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:04:44 INFO - Return code: 0 03:04: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:04:44 INFO - https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:04:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:04:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:04:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:04:45 INFO - Downloaded 10840145 bytes. 03:04:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:04:46 INFO - Return code: 0 03:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:46 INFO - https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:04:48 INFO - Downloaded 56010300 bytes. 03:04:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:04:48 INFO - mkdir: /builds/slave/test/properties 03:04:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:04:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:04:48 INFO - Contents: 03:04:48 INFO - build_url:https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:04:48 INFO - Running post-action listener: _resource_record_post_action 03:04:48 INFO - Running post-action listener: set_extra_try_arguments 03:04:48 INFO - ##### 03:04:48 INFO - ##### Running populate-webroot step. 03:04:48 INFO - ##### 03:04:48 INFO - Running pre-action listener: _resource_record_pre_action 03:04:48 INFO - Running main action method: populate_webroot 03:04:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:04:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:04:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:04:48 INFO - '--tppagecycles', 03:04:48 INFO - '7'], 03:04:48 INFO - 'tests': ['tsvgm']}}, 03:04:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:04:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:04:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:04:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:04:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['damp', 'tps']}, 03:04:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'tests': ['damp', 'tps']}, 03:04:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['dromaeo_dom']}, 03:04:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:04:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['a11yr', 03:04:48 INFO - 'ts_paint', 03:04:48 INFO - 'tpaint', 03:04:48 INFO - 'sessionrestore', 03:04:48 INFO - 'sessionrestore_no_auto_restore', 03:04:48 INFO - 'tabpaint']}, 03:04:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tsvgx', 03:04:48 INFO - 'tsvgr_opacity', 03:04:48 INFO - 'tart', 03:04:48 INFO - 'tscrollx', 03:04:48 INFO - 'cart']}, 03:04:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:04:48 INFO - 'tsvgr_opacity', 03:04:48 INFO - 'tart', 03:04:48 INFO - 'tscrollx', 03:04:48 INFO - 'cart']}, 03:04:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s'], 03:04:48 INFO - 'tests': ['tp5o']}, 03:04:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'tests': ['tp5o']}, 03:04:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--disable-e10s', 03:04:48 INFO - '--xperf_path', 03:04:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:48 INFO - 'tests': ['tp5n']}, 03:04:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:48 INFO - 'talos_options': ['--xperf_path', 03:04:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:48 INFO - 'tests': ['tp5n']}}, 03:04:48 INFO - 'talos.zip': {'path': '', 03:04:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:04:48 INFO - Running post-action listener: _resource_record_post_action 03:04:48 INFO - ##### 03:04:48 INFO - ##### Running create-virtualenv step. 03:04:48 INFO - ##### 03:04:48 INFO - Running pre-action listener: _resource_record_pre_action 03:04:48 INFO - Running main action method: create_virtualenv 03:04:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:04:48 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:04:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:04:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:04:49 INFO - Using real prefix '/usr' 03:04:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:04:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:04:51 INFO - Installing pip.................done. 03:04:51 INFO - Return code: 0 03:04:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:04: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:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04: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:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:04: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', 'pip>=1.5'] in /builds/slave/test/build 03:04: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 pip>=1.5 03:04:51 INFO - Using env: {'DISPLAY': ':0', 03:04:51 INFO - 'HOME': '/home/cltbld', 03:04:51 INFO - 'LANG': 'en_US.UTF-8', 03:04:51 INFO - 'LANGUAGE': 'en_US:en', 03:04:51 INFO - 'LOGNAME': 'cltbld', 03:04:51 INFO - 'MAIL': '/var/mail/cltbld', 03:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:51 INFO - 'MOZ_NO_REMOTE': '1', 03:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:51 INFO - 'NO_EM_RESTART': '1', 03:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:51 INFO - 'PWD': '/builds/slave/test', 03:04:51 INFO - 'SHELL': '/bin/bash', 03:04:51 INFO - 'SHLVL': '1', 03:04:51 INFO - 'TERM': 'linux', 03:04:51 INFO - 'TMOUT': '86400', 03:04:51 INFO - 'USER': 'cltbld', 03:04:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:51 INFO - '_': '/tools/buildbot/bin/python'} 03:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:04:52 INFO - Cleaning up... 03:04:52 INFO - Return code: 0 03:04:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:04:52 INFO - Using env: {'DISPLAY': ':0', 03:04:52 INFO - 'HOME': '/home/cltbld', 03:04:52 INFO - 'LANG': 'en_US.UTF-8', 03:04:52 INFO - 'LANGUAGE': 'en_US:en', 03:04:52 INFO - 'LOGNAME': 'cltbld', 03:04:52 INFO - 'MAIL': '/var/mail/cltbld', 03:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:52 INFO - 'MOZ_NO_REMOTE': '1', 03:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:52 INFO - 'NO_EM_RESTART': '1', 03:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:52 INFO - 'PWD': '/builds/slave/test', 03:04:52 INFO - 'SHELL': '/bin/bash', 03:04:52 INFO - 'SHLVL': '1', 03:04:52 INFO - 'TERM': 'linux', 03:04:52 INFO - 'TMOUT': '86400', 03:04:52 INFO - 'USER': 'cltbld', 03:04:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:52 INFO - '_': '/tools/buildbot/bin/python'} 03:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:52 INFO - Downloading/unpacking psutil>=0.7.1 03:04:52 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:04:52 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:04:52 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:04:52 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:04:52 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:04:52 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:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:54 INFO - Installing collected packages: psutil 03:04:54 INFO - Running setup.py install for psutil 03:04:54 INFO - building 'psutil._psutil_linux' extension 03:04:54 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:04:54 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:04:54 INFO - building 'psutil._psutil_posix' extension 03:04:54 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:04:54 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:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:54 INFO - Successfully installed psutil 03:04:54 INFO - Cleaning up... 03:04:54 INFO - Return code: 0 03:04:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:54 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 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:04:54 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:04:54 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:04:54 INFO - Using env: {'DISPLAY': ':0', 03:04:54 INFO - 'HOME': '/home/cltbld', 03:04:54 INFO - 'LANG': 'en_US.UTF-8', 03:04:54 INFO - 'LANGUAGE': 'en_US:en', 03:04:54 INFO - 'LOGNAME': 'cltbld', 03:04:54 INFO - 'MAIL': '/var/mail/cltbld', 03:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:54 INFO - 'MOZ_NO_REMOTE': '1', 03:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:54 INFO - 'NO_EM_RESTART': '1', 03:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:54 INFO - 'PWD': '/builds/slave/test', 03:04:54 INFO - 'SHELL': '/bin/bash', 03:04:54 INFO - 'SHLVL': '1', 03:04:54 INFO - 'TERM': 'linux', 03:04:54 INFO - 'TMOUT': '86400', 03:04:54 INFO - 'USER': 'cltbld', 03:04:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:54 INFO - '_': '/tools/buildbot/bin/python'} 03:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:04:55 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:04:55 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:04:55 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:04:55 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:04:55 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:04:55 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:04:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:04:56 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:04:56 INFO - Installing collected packages: mozsystemmonitor 03:04:56 INFO - Running setup.py install for mozsystemmonitor 03:04:57 INFO - Successfully installed mozsystemmonitor 03:04:57 INFO - Cleaning up... 03:04:57 INFO - Return code: 0 03:04:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:04:57 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:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:57 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:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:57 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 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:04:57 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:04:57 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:04:57 INFO - Using env: {'DISPLAY': ':0', 03:04:57 INFO - 'HOME': '/home/cltbld', 03:04:57 INFO - 'LANG': 'en_US.UTF-8', 03:04:57 INFO - 'LANGUAGE': 'en_US:en', 03:04:57 INFO - 'LOGNAME': 'cltbld', 03:04:57 INFO - 'MAIL': '/var/mail/cltbld', 03:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:57 INFO - 'MOZ_NO_REMOTE': '1', 03:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:57 INFO - 'NO_EM_RESTART': '1', 03:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:57 INFO - 'PWD': '/builds/slave/test', 03:04:57 INFO - 'SHELL': '/bin/bash', 03:04:57 INFO - 'SHLVL': '1', 03:04:57 INFO - 'TERM': 'linux', 03:04:57 INFO - 'TMOUT': '86400', 03:04:57 INFO - 'USER': 'cltbld', 03:04:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:57 INFO - '_': '/tools/buildbot/bin/python'} 03:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:04:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:04: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:04: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:04: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:04: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:04: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:04: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:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:05:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:00 INFO - Downloading docopt-0.6.1.tar.gz 03:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:05:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:05:00 INFO - Running setup.py install for blobuploader 03:05:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:05:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:05:00 INFO - Running setup.py install for requests 03:05:01 INFO - Running setup.py install for docopt 03:05:01 INFO - Successfully installed blobuploader requests docopt 03:05:01 INFO - Cleaning up... 03:05:01 INFO - Return code: 0 03:05:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:01 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 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:05:01 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:05:01 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:05:01 INFO - Using env: {'DISPLAY': ':0', 03:05:01 INFO - 'HOME': '/home/cltbld', 03:05:01 INFO - 'LANG': 'en_US.UTF-8', 03:05:01 INFO - 'LANGUAGE': 'en_US:en', 03:05:01 INFO - 'LOGNAME': 'cltbld', 03:05:01 INFO - 'MAIL': '/var/mail/cltbld', 03:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:01 INFO - 'MOZ_NO_REMOTE': '1', 03:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:01 INFO - 'NO_EM_RESTART': '1', 03:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:01 INFO - 'PWD': '/builds/slave/test', 03:05:01 INFO - 'SHELL': '/bin/bash', 03:05:01 INFO - 'SHLVL': '1', 03:05:01 INFO - 'TERM': 'linux', 03:05:01 INFO - 'TMOUT': '86400', 03:05:01 INFO - 'USER': 'cltbld', 03:05:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:01 INFO - '_': '/tools/buildbot/bin/python'} 03:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:01 INFO - Running setup.py (path:/tmp/pip-Ax5W9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:01 INFO - Running setup.py (path:/tmp/pip-Lc7QSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:01 INFO - Running setup.py (path:/tmp/pip-4CKhk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:01 INFO - Running setup.py (path:/tmp/pip-VldLNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:01 INFO - Running setup.py (path:/tmp/pip-hf_MPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:01 INFO - Running setup.py (path:/tmp/pip-1uaBgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:01 INFO - Running setup.py (path:/tmp/pip-qL9EwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:01 INFO - Running setup.py (path:/tmp/pip-JtHaCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:02 INFO - Running setup.py (path:/tmp/pip-kwrOZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:02 INFO - Running setup.py (path:/tmp/pip-k_6Uws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:02 INFO - Running setup.py (path:/tmp/pip-3WVSjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:02 INFO - Running setup.py (path:/tmp/pip-x2EC1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:02 INFO - Running setup.py (path:/tmp/pip-5BuLSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:02 INFO - Running setup.py (path:/tmp/pip-XP6evD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:02 INFO - Running setup.py (path:/tmp/pip-jofwXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:02 INFO - Running setup.py (path:/tmp/pip-w_LeLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:02 INFO - Running setup.py (path:/tmp/pip-8JCohP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:05:02 INFO - Running setup.py install for manifestparser 03:05:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:05:02 INFO - Running setup.py install for mozcrash 03:05:02 INFO - Running setup.py install for mozdebug 03:05:02 INFO - Running setup.py install for mozdevice 03:05:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Running setup.py install for mozfile 03:05:03 INFO - Running setup.py install for mozhttpd 03:05:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Running setup.py install for mozinfo 03:05:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Running setup.py install for mozInstall 03:05:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Running setup.py install for mozleak 03:05:03 INFO - Running setup.py install for mozlog 03:05:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Running setup.py install for moznetwork 03:05:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Running setup.py install for mozprocess 03:05:03 INFO - Running setup.py install for mozprofile 03:05:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:05:03 INFO - Running setup.py install for mozrunner 03:05:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:05:04 INFO - Running setup.py install for mozscreenshot 03:05:04 INFO - Running setup.py install for moztest 03:05:04 INFO - Running setup.py install for mozversion 03:05:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:05:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:05:04 INFO - Cleaning up... 03:05:04 INFO - Return code: 0 03:05:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:04 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:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:04 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:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:04 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 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:05:04 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:05:04 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:05:04 INFO - Using env: {'DISPLAY': ':0', 03:05:04 INFO - 'HOME': '/home/cltbld', 03:05:04 INFO - 'LANG': 'en_US.UTF-8', 03:05:04 INFO - 'LANGUAGE': 'en_US:en', 03:05:04 INFO - 'LOGNAME': 'cltbld', 03:05:04 INFO - 'MAIL': '/var/mail/cltbld', 03:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:04 INFO - 'MOZ_NO_REMOTE': '1', 03:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:04 INFO - 'NO_EM_RESTART': '1', 03:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:04 INFO - 'PWD': '/builds/slave/test', 03:05:04 INFO - 'SHELL': '/bin/bash', 03:05:04 INFO - 'SHLVL': '1', 03:05:04 INFO - 'TERM': 'linux', 03:05:04 INFO - 'TMOUT': '86400', 03:05:04 INFO - 'USER': 'cltbld', 03:05:04 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:04 INFO - '_': '/tools/buildbot/bin/python'} 03:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:04 INFO - Running setup.py (path:/tmp/pip-WlbaeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:04 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:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:04 INFO - Running setup.py (path:/tmp/pip-kOvSon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:04 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:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:04 INFO - Running setup.py (path:/tmp/pip-wV6Z4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:04 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:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:04 INFO - Running setup.py (path:/tmp/pip-HMfyxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:04 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:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:04 INFO - Running setup.py (path:/tmp/pip-L_Ub_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:05 INFO - Running setup.py (path:/tmp/pip-UqRwJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:05 INFO - Running setup.py (path:/tmp/pip-OqMyzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:05 INFO - Running setup.py (path:/tmp/pip-wzwTyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:05 INFO - Running setup.py (path:/tmp/pip-MfrNuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:05 INFO - Running setup.py (path:/tmp/pip-JOzF0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:05 INFO - Running setup.py (path:/tmp/pip-UPe7PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:05 INFO - Running setup.py (path:/tmp/pip-cQelMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:05 INFO - Running setup.py (path:/tmp/pip-9uQm81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:05 INFO - Running setup.py (path:/tmp/pip-TzNnQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:05 INFO - Running setup.py (path:/tmp/pip-tq3xAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:05 INFO - Running setup.py (path:/tmp/pip-bwhqJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:05 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:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:05 INFO - Running setup.py (path:/tmp/pip-CQlcLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:05: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:05: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:05: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:05: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:05: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:05: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:05:07 INFO - Downloading blessings-1.6.tar.gz 03:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:05:07 INFO - Installing collected packages: blessings 03:05:07 INFO - Running setup.py install for blessings 03:05:07 INFO - Successfully installed blessings 03:05:07 INFO - Cleaning up... 03:05:08 INFO - Return code: 0 03:05:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:08 INFO - Reading from file tmpfile_stdout 03:05:08 INFO - Current package versions: 03:05:08 INFO - argparse == 1.2.1 03:05:08 INFO - blessings == 1.6 03:05:08 INFO - blobuploader == 1.2.4 03:05:08 INFO - docopt == 0.6.1 03:05:08 INFO - manifestparser == 1.1 03:05:08 INFO - mozInstall == 1.12 03:05:08 INFO - mozcrash == 0.17 03:05:08 INFO - mozdebug == 0.1 03:05:08 INFO - mozdevice == 0.48 03:05:08 INFO - mozfile == 1.2 03:05:08 INFO - mozhttpd == 0.7 03:05:08 INFO - mozinfo == 0.9 03:05:08 INFO - mozleak == 0.1 03:05:08 INFO - mozlog == 3.1 03:05:08 INFO - moznetwork == 0.27 03:05:08 INFO - mozprocess == 0.22 03:05:08 INFO - mozprofile == 0.28 03:05:08 INFO - mozrunner == 6.11 03:05:08 INFO - mozscreenshot == 0.1 03:05:08 INFO - mozsystemmonitor == 0.0 03:05:08 INFO - moztest == 0.7 03:05:08 INFO - mozversion == 1.4 03:05:08 INFO - psutil == 3.1.1 03:05:08 INFO - requests == 1.2.3 03:05:08 INFO - wsgiref == 0.1.2 03:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:08 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:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:08 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:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:08 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 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:05:08 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:05:08 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:05:08 INFO - Using env: {'DISPLAY': ':0', 03:05:08 INFO - 'HOME': '/home/cltbld', 03:05:08 INFO - 'LANG': 'en_US.UTF-8', 03:05:08 INFO - 'LANGUAGE': 'en_US:en', 03:05:08 INFO - 'LOGNAME': 'cltbld', 03:05:08 INFO - 'MAIL': '/var/mail/cltbld', 03:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:08 INFO - 'MOZ_NO_REMOTE': '1', 03:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:08 INFO - 'NO_EM_RESTART': '1', 03:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:08 INFO - 'PWD': '/builds/slave/test', 03:05:08 INFO - 'SHELL': '/bin/bash', 03:05:08 INFO - 'SHLVL': '1', 03:05:08 INFO - 'TERM': 'linux', 03:05:08 INFO - 'TMOUT': '86400', 03:05:08 INFO - 'USER': 'cltbld', 03:05:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:08 INFO - '_': '/tools/buildbot/bin/python'} 03:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 INFO - Cleaning up... 03:05:08 INFO - Return code: 0 03:05:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:05:08 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:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:08 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:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:08 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 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:05:08 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:05:08 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:05:08 INFO - Using env: {'DISPLAY': ':0', 03:05:08 INFO - 'HOME': '/home/cltbld', 03:05:08 INFO - 'LANG': 'en_US.UTF-8', 03:05:08 INFO - 'LANGUAGE': 'en_US:en', 03:05:08 INFO - 'LOGNAME': 'cltbld', 03:05:08 INFO - 'MAIL': '/var/mail/cltbld', 03:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:08 INFO - 'MOZ_NO_REMOTE': '1', 03:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:08 INFO - 'NO_EM_RESTART': '1', 03:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:08 INFO - 'PWD': '/builds/slave/test', 03:05:08 INFO - 'SHELL': '/bin/bash', 03:05:08 INFO - 'SHLVL': '1', 03:05:08 INFO - 'TERM': 'linux', 03:05:08 INFO - 'TMOUT': '86400', 03:05:08 INFO - 'USER': 'cltbld', 03:05:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:08 INFO - '_': '/tools/buildbot/bin/python'} 03:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:08 INFO - Downloading/unpacking jsonschema 03:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:08 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:05:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:05:10 INFO - Downloading/unpacking functools32 (from jsonschema) 03:05:10 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:05:10 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:05:10 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:05:10 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:05:10 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:05:10 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:05:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:05:10 INFO - warning: no files found matching '*.txt' 03:05:10 INFO - no previously-included directories found matching 'build' 03:05:10 INFO - no previously-included directories found matching 'dist' 03:05:10 INFO - no previously-included directories found matching '.git*' 03:05:10 INFO - Installing collected packages: jsonschema, functools32 03:05:10 INFO - Running setup.py install for functools32 03:05:10 INFO - warning: no files found matching '*.txt' 03:05:10 INFO - no previously-included directories found matching 'build' 03:05:10 INFO - no previously-included directories found matching 'dist' 03:05:10 INFO - no previously-included directories found matching '.git*' 03:05:11 INFO - Successfully installed jsonschema functools32 03:05:11 INFO - Cleaning up... 03:05:11 INFO - Return code: 0 03:05:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:11 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 0x7fdc55eebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', '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:05:11 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:05:11 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:05:11 INFO - Using env: {'DISPLAY': ':0', 03:05:11 INFO - 'HOME': '/home/cltbld', 03:05:11 INFO - 'LANG': 'en_US.UTF-8', 03:05:11 INFO - 'LANGUAGE': 'en_US:en', 03:05:11 INFO - 'LOGNAME': 'cltbld', 03:05:11 INFO - 'MAIL': '/var/mail/cltbld', 03:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:11 INFO - 'MOZ_NO_REMOTE': '1', 03:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:11 INFO - 'NO_EM_RESTART': '1', 03:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:11 INFO - 'PWD': '/builds/slave/test', 03:05:11 INFO - 'SHELL': '/bin/bash', 03:05:11 INFO - 'SHLVL': '1', 03:05:11 INFO - 'TERM': 'linux', 03:05:11 INFO - 'TMOUT': '86400', 03:05:11 INFO - 'USER': 'cltbld', 03:05:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:11 INFO - '_': '/tools/buildbot/bin/python'} 03:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:11 INFO - Downloading/unpacking flake8 03:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:05:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:05:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:05:13 INFO - no previously-included directories found matching 'docs/_build' 03:05:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:05:13 INFO - Running setup.py install for pep8 03:05:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:05:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:05:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:05:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:05:14 INFO - no previously-included directories found matching 'docs/_build' 03:05:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:05:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:05:14 INFO - Cleaning up... 03:05:14 INFO - Return code: 0 03:05:14 INFO - Running post-action listener: _resource_record_post_action 03:05:14 INFO - Running post-action listener: _start_resource_monitoring 03:05:14 INFO - Starting resource monitoring. 03:05:14 INFO - ##### 03:05:14 INFO - ##### Running install step. 03:05:14 INFO - ##### 03:05:14 INFO - Running pre-action listener: _resource_record_pre_action 03:05:14 INFO - Running main action method: install 03:05:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:14 INFO - Reading from file tmpfile_stdout 03:05:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:05:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:05:14 INFO - Reading from file tmpfile_stdout 03:05:14 INFO - Output received: 03:05:14 INFO - Usage: mozinstall [options] installer 03:05:14 INFO - Options: 03:05:14 INFO - -h, --help show this help message and exit 03:05:14 INFO - -d DEST, --destination=DEST 03:05:14 INFO - Directory to install application into. [default: 03:05:14 INFO - "/builds/slave/test"] 03:05:14 INFO - --app=APP Application being installed. [default: firefox] 03:05:14 INFO - mkdir: /builds/slave/test/build/application 03:05:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:05:27 INFO - Reading from file tmpfile_stdout 03:05:27 INFO - Output received: 03:05:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:05:27 INFO - Running post-action listener: _resource_record_post_action 03:05:27 INFO - ##### 03:05:27 INFO - ##### Running run-tests step. 03:05:27 INFO - ##### 03:05:27 INFO - Running pre-action listener: _resource_record_pre_action 03:05:27 INFO - Running main action method: run_tests 03:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:05:27 INFO - Python 2.7.3 03:05:27 INFO - Return code: 0 03:05:27 INFO - grabbing minidump binary from tooltool 03:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:27 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 0x1f46410>, '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 0x1f47310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f477a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:05:27 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:05:27 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:05:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:27 INFO - Return code: 0 03:05:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:05:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:05:28 INFO - Return code: 0 03:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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:05:28 INFO - Using env: {'DISPLAY': ':0', 03:05:28 INFO - 'HOME': '/home/cltbld', 03:05:28 INFO - 'LANG': 'en_US.UTF-8', 03:05:28 INFO - 'LANGUAGE': 'en_US:en', 03:05:28 INFO - 'LOGNAME': 'cltbld', 03:05:28 INFO - 'MAIL': '/var/mail/cltbld', 03:05:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:28 INFO - 'MOZ_NO_REMOTE': '1', 03:05:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:28 INFO - 'NO_EM_RESTART': '1', 03:05:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:28 INFO - 'PWD': '/builds/slave/test', 03:05:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:28 INFO - 'SHELL': '/bin/bash', 03:05:28 INFO - 'SHLVL': '1', 03:05:28 INFO - 'TERM': 'linux', 03:05:28 INFO - 'TMOUT': '86400', 03:05:28 INFO - 'USER': 'cltbld', 03:05:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567', 03:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:28 INFO - '_': '/tools/buildbot/bin/python'} 03:05:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:05:28 INFO - mozversion application_buildid: 20160621002003 03:05:28 INFO - mozversion application_changeset: bef93a95add04ae173138d8391603bf77f9ae666 03:05:28 INFO - mozversion application_display_name: Firefox 03:05:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:28 INFO - mozversion application_name: Firefox 03:05:28 INFO - mozversion application_remotingname: firefox 03:05:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:05:28 INFO - mozversion application_vendor: Mozilla 03:05:28 INFO - mozversion application_version: 48.0 03:05:28 INFO - mozversion platform_buildid: 20160621002003 03:05:28 INFO - mozversion platform_changeset: bef93a95add04ae173138d8391603bf77f9ae666 03:05:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:05:28 INFO - mozversion platform_version: 48.0 03:05:28 INFO - using testdate: 1466503528 03:05:28 INFO - actual date: 1466503528 03:05:28 INFO - starting webserver on 'localhost:50971' 03:05:28 INFO - SUITE-START | Running 2 tests 03:05:28 INFO - TEST-START | dromaeo_css 03:05:28 INFO - operating with platform_type : linux_ 03:05:28 INFO - Initialising browser for dromaeo_css test... 03:05:28 INFO - TEST-INFO | started process 10854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgm5BVd/profile http://localhost:50971/getInfo.html) 03:05:32 INFO - PROCESS | 10854 | __metrics Screen width/height:1600/1200 03:05:32 INFO - PROCESS | 10854 | colorDepth:24 03:05:32 INFO - PROCESS | 10854 | Browser inner width/height: 1024/697 03:05:32 INFO - PROCESS | 10854 | __metrics 03:05:33 ERROR - PROCESS | 10854 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:05:34 INFO - TEST-INFO | 10854: exit 0 03:05:34 INFO - Browser initialized. 03:05:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:05:34 INFO - TEST-INFO | started process 10945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgm5BVd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:46 INFO - PROCESS | 10945 | RSS: Main: 141377536 03:05:46 INFO - PROCESS | 10945 | 03:06:37 INFO - PROCESS | 10945 | 1466503597393 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:08:44 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:50971/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50971/tests/dromaeo/cssquery-ext.html) 03:08:45 INFO - PROCESS | 10945 | RSS: Main: 244666368 03:08:45 INFO - PROCESS | 10945 | 03:11:47 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:50971/tests/dromaeo/cssquery-ext.html (next: http://localhost:50971/tests/dromaeo/cssquery-jquery.html) 03:11:48 INFO - PROCESS | 10945 | RSS: Main: 221876224 03:11:48 INFO - PROCESS | 10945 | 03:14:50 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:50971/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50971/tests/dromaeo/cssquery-mootools.html) 03:14:50 INFO - PROCESS | 10945 | RSS: Main: 214331392 03:14:50 INFO - PROCESS | 10945 | 03:17:52 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:50971/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50971/tests/dromaeo/cssquery-prototype.html) 03:17:53 INFO - PROCESS | 10945 | RSS: Main: 214597632 03:17:53 INFO - PROCESS | 10945 | 03:20:55 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:50971/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50971/tests/dromaeo/cssquery-yui.html) 03:20:56 INFO - PROCESS | 10945 | RSS: Main: 206299136 03:20:56 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:50971/tests/dromaeo/cssquery-yui.html (next: http://localhost:50971/tests/dromaeo/cssquery-dojo.html) 03:23:58 INFO - PROCESS | 10945 | RSS: Main: 258887680 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | __start_tp_report 03:23:58 INFO - PROCESS | 10945 | _x_x_mozilla_page_load 03:23:58 INFO - PROCESS | 10945 | _x_x_mozilla_page_load_details 03:23:58 INFO - PROCESS | 10945 | |i|pagename|runs| 03:23:58 INFO - PROCESS | 10945 | |0;dojo.html;3279.918002049949;3372.6121496027963;3377.8817741379057;3405.0976491229812;3422.0760394693434;5607.158926161078;5611.046122159238;5613.775448982046;5624.184493248476;5624.971875140619;5606.719664016793;5625.634333768302;5636.689982050985;5640.0693885508945;5645.2096706461125;4901.142300097486;5090.134677104892;5178.093833579127;5207.713575753332;5243.86890327741;5079.03498335317;5112.233165025257;5148.485151484859;5155.4586768389345;5158.819441319554;5127.256547800566;5133.178691409356;5191.610629202806;5221.921671174935;5222.112240919034;5164.922526162091;5166.07010738067;5167.431582525919;5168.069747445458;5196.142636464979;4862.756862156878;5048.368953880765;5051.469595692436;5074.746262686851;5114.565261952738;5390.110631745757;5422.186671999192;5453.481919217668;5469.644473109235;5474.671519708831;5957.165996760457;5967.045272756382;5969.134475501071;5973.970130149365;5976.611520251213;5896.410358964112;6008.549358798107;6055.031195008777;6075.605085669417;6078.787242446538;5570.192322113311;5596.720163991784;5622.803201887914;5622.831315060595;5631.5776316776;6040.939590604038;6110.175126357974;6115.449609535163;6121.969390153021;6123.663198524035;5840.269966254218;5890.057590785454;5900.881982360329;5914;5928;5952.136940143655;5959.702014899238;5966.194563733927;5966.433188847052;5970.402959704082;5875.6180848245585;5905;5928.258967629046;5936.5250779937505;5943.673097979567;5955.166276721263;5995.070764031582;5996.760129594767;5999.850003749942;6043.395660433922;4542.613877820422;4546.1135078659345;4546.818127274938;4548.931766023512;4573.748443835554;3986.86045988389;4040.939385909214;4041.9191616167514;4067.4102255173425;4113.71204015722;5773.39379365169;5785.537157027427;5786.855328616818;5793.159991801165;5831.679257640785;6017;6051.122587224916;6060.848478788065;6063.029915213633;6072.726727297282;5578.860528486739;5612.635178713371;5707.429257074343;5776.220210271644;5784.566157538202;5050.4697006814495;5057.342545469065;5061.6962982221185;5062.063518249136;5086.77109530072;6302.968485157637;6326.082718005863;6326.145970294044;6330.778422755181;6332.0818481320875;5935.109733540004;6015.639061656315;6080.209572755513;6085.57400981927;6117.265928088658;6032.487238584769;6038.184845045863;6072.180255665606;6076.6961651916345;6094.11635312886;5754;5758.884822303614;5759.65442073477;5760.683162426107;5786.247787787561;5846.210761547137;5891.617044892068;5967.283925928917;6047.304559975659;6066.545009124245;5799.188113664175;5803.361630220588;5804.82585522435;5808.419158084158;5808.5643576732755;5748.223989761496;5814.215080964185;5814.505767009851;5815.04051831443;5815.127730840408;5694.572907032072;5778.566607504538;5815.738291776795;5839.270091238595;5844.503217226584;5734.627249228787;5740.253767010262;5752.7698892043845;5756.0502517084215;5772.307323121252;5608.831735047955;5613.101903695389;5613.354464236501;5613.663180209201;5668.7165641718575 03:23:58 INFO - PROCESS | 10945 | |1;ext.html;600.9008513595257;661.0579923608856;662.3145044878552;667.7762949411947;667.8497338098929;33011.83494082529;33578.66421335786;33603.49594756075;33644.327113457715;33647.49528757071;34441.48337774929;41869.371959420554;42713.7864310678;42733.57266427335;42792;8810.07494213108;8983.19151276385;8987.505687187202;8989.415687980292;8992.505412202327;8347.874781878276;8734.301255899545;8841.115888411172;10759.83860242097;11062.889371106266;10671.733206669856;10759.193060520452;10770.192235582323;10771.730706732316;10777.730556736105;10606.628767993121;10680;10685.679429617046;10689.358638481639;10697.572097116106;10430.634927777568;10514.158867290598;10521.316114452537;10569.312994655324;10576.947115264451;40183.397249041285;40467.7976610118;44931.32603010957;44938;44942.55057449449;3677.3748462761396;3743.625637436262;3765.435184722286;3796.54441467023;3873.845046198149;34394.14014649629;34816.47775283373;34838;34868.65131348705;35022.29955400878;4607.4471063472265;4661.347411362412;4679.438467383936;4715.245560710304;4826.565609095198;219626;220768;221445;221522;221683.89158054267;39885.601143988766;40557.797211013756;40614;65476.34523654702;65563;37994.81002594969;38009.80995095007;38114.23771524554;38121.42817857734;38125;16847.241874115694;17038.31846726142;17056.57358566046;17072;17079.743803842954;14369.209693466959;14407.92796036034;14411.92794036023;14431.134131952116;14449.78325325121;8880.111988801198;9364.906350936404;9593.088656577615;9593.568289426992;9612.615495380247;3560.8812756409893;3650.393826716236;3679.0802299425145;3691.1694868654877;3703.5370578677666;1063.505469956474;1063.9308444951052;1122.4331712485143;1129.497373668726;1130.8077626803463;33486.66513334835;33572.1606959828;34044.31911361759;34251.82874085614;34284.82857585746;1212.7331986962854;1227.8526576810839;1232.2298563397876;1292.6768307923019;1336.565616174747;17702.911485442746;17901.462956111336;17946.64106717858;18109.63780724378;18209.7268540972;438296;443111;443963;444055;445557;62813.68593157005;63527.04709429362;63586.36413635897;63591.6820415895;63621.68189159025;1367.9110857794212;1422.8972546276718;1522.596511924341;1526.778617100514;1535.3091109000993;30544;31133.377332453678;32925.83537082299;33237.667623323454;34001.31997360088;52103.21845172401;52310.73844630752;52642.73678631582;52644.21033684421;52667.473325266255;294874;295087;295670;295859;296394;27437;31304.843475782476;31664.841675791475;31665.525017124302;31753;48287.75856120697;50080.499195007586;50620.24069639032;50967.23549146692;51825;41025.384619230135;41426.37860432156;41532.58467415287;41851;42412;39466;40483.79758101191;40787.38818917659;41406.378904315854;42087.789561052;41725;42535.787321063195;42824.78587607042;43407.78296108625;43623.34564981464;35613.64386356103;37130.44304335491;37196.44205336868;37921.43117853179;38116;28500.85749571239;28587.42825143527;28717.71282287234;28901.71098289074;28960.13119606415 03:23:58 INFO - PROCESS | 10945 | |2;jquery.html;422.8012833968034;424.84705506017826;435.92589259825826;440.825873779857;441.5385921711811;18557;18576.535586610342;18772.43682689518;19270.903645481787;19369.22523099076;18421.17104730287;18606.16272267748;19402.90298548509;19493.22027118917;19547.120379582917;5574.9721251393685;5577.52591029763;5751.396103409144;5795.246617939683;5804.970975145118;5705.4294570543025;5762.56780741444;5770.942290577103;5782.566307526931;5798.971005144989;5510.9448905511035;5733.082706766918;5734.913976290359;5741.425857414267;5762.971185144069;5703.942960570383;5727.455891690282;5745.138229265602;5754.625949313281;5760.913586296209;5098.133317336024;5118.360204974379;5120.334356533664;5141.84574462763;5194.63637545372;23466.413339666473;23470.17854375106;23773.762262377328;24130.276091717278;24201.273961781175;2431.367844360479;2485.751424857518;2829.8302101873746;3264.934701305984;3287.8356082195796;10180.338278011906;13450.596482105553;13556.389962451713;13928.37322320498;14128.858711412857;2019.8182163605345;2056.9485762855898;2067.58648270345;2077.6779599162155;2154.6983422320886;74837.62581187114;76656.61671691606;78802;79617.60191199007;80803.19196808015;10728.195385346131;10915.617953371593;11182.384968826793;11198.888011119947;11323.358113073558;15266.084034957716;15469.767953480707;15713.68572628541;15746.212689365486;15810.446634367741;8563.743087707378;8620.870686939701;8626;9016.18854303116;9028.909710902806;8863.394182028182;8894.377393582387;8901.866472002925;9014.549272536347;9039.096090390909;6744.898826517606;6780.898286525706;6825.863482730417;6895.724171033203;6932.480063995221;2015.5263513074415;2017.1729590867674;2020.7575090988882;2062.0823733438774;2071.461420030803;1013.4780587997187;1081.2755453845941;1100.6422912553292;1141.594733869481;1152.5389844062443;18867.81132188688;20056.799432005784;20135.899320503304;20412.693809592867;20582.897085514775;1121.775644871029;1131.8358837968449;1159.5361855257963;1167.8189880568525;1189.8155785853207;11395.829062564067;11424.543018279343;11433.042299565528;11464.36945967963;11642.359670218219;477494.5127469203;479205;503501;504850;512544;49277.50722492729;49513.75243123761;65323.67338163279;69453.30546694469;84961;1107.7286064914147;1114.0975809594254;1134.3930996916445;1139.641013080877;1152.1819508149308;13292.534761283308;16928.645708343058;17279.22243499071;17451.30194792194;17771.911140444216;34840.651593484756;36816;37005.44491832571;38158.61841381551;38957.80521097376;49102.26346604875;49715;49795;50004;50135.49864501308;9274.118958699182;9390.718278451657;9421.118012422361;9467.952660236655;9483.762905927408;13189.538366157138;13984.510542130976;14116.364763585869;14200.28998550089;14239.288035597972;11852.229605075643;12169.39153042362;12177.878221217674;12405.689857753629;12729.648321397997;12049.638510844688;12057.095717821023;12080.39598020113;12225.388730563614;12361.567345142877;12173.20874143178;12251.509939602316;12299.323537205539;12433.93783031079;12597.685057873627;8581.570921454027;8810.64757409722;8826.514541700268;8937.150970657776;8953.149450802164;11068.723281918017;12098;12123.393830308625;12190.2076365036;12243.20419172751 03:23:58 INFO - PROCESS | 10945 | |3;mootools.html;1436.4182506085026;1557.9221038948053;1590.9204539773011;1804.4676820338;1937.8837269763806;7835.843283134334;8527.635578307472;8639.52482613456;8641.611127499262;8652.134786521345;8435.789105272372;8613.569321533929;8615.741527754177;8629.784255393619;8648.783780405478;2116.153538584567;2128.063651993118;2135.220644464767;2138.764735879052;2141.635921893274;2367.1478267823654;2399.1123284384803;2428.101602407112;2430.6232533957264;2443.022790883643;2405.434722840131;2423.4789520253144;2434.221049264227;2463.6427717980882;2464.322311364371;2376.9524609507885;2408.0969636386353;2409.1929203716863;2409.662647229389;2446.217210492643;2282.863028218312;2380.5238952209456;2393.8204634652297;2393.832431729762;2394.5570069537193;7615.31462168402;8290.8341833163;8768.254698350584;8832.425892316978;8834.983976842681;5241.68549887008;5355.491228333302;5362.436944120889;5364.356277246717;5366.087765079946;3497.387957107496;3497.615262321143;3501.072215862798;3505.6319086495805;3577.5706915170085;1095.2935356694886;1096.780643871221;1109.295597295715;1112.8330750387427;1113.6770336602376;11931.522739090426;12362.196457230251;12375.504979800797;12381.75236495265;12386.75226495465;4624.121416930772;4637.791299391535;4734.721625161187;4749.050189962021;4759.357486739246;10574.206934479791;10649.893501065046;10655.57377704883;10661.147108231324;10705.9464702676;5487.039768040577;5515.25544051556;5515.503604675519;5516.14499752539;5527.972360138254;4919.040787046563;4987.551120399182;4991.026749783758;5000.374953130859;5004.674696144739;3921.784301863425;4010.2380547695843;4044.2518134145275;4045.5347635021762;4059.5331536873045;1197.5329621447643;1202.0864143251192;1209.195884736658;1217.245307909102;1223.7736018836545;1035.3115178406426;1041.7760181561;1047.9895201048043;1051.0540513537724;1067.5036108209565;5824.767009319579;5828.941710582924;5910.113482977502;6097.298810636745;6137.447629713347;989.4706332112286;1048.1614708233535;1075.9623413180502;1078.0405439159154;1086.9293495922739;3889.2999260133447;3916.1580260244186;3993.281209382339;4031.737937034083;4034.757914525138;10597.9470102649;10933.835992460119;11035.2275340727;11107.611233606785;11121.944390278159;10746.194035447374;10933.507992140372;10938.671839844657;10939.12487001038;10941.23411361213;8310.376721745894;8441.873371899426;8491.702790402429;8545.786355341166;8548.358873084544;5593.105103183471;5666.829995100154;5693.430656934273;5758.942410575841;5866.5893387464175;9422.575984080595;9500.192483638968;9726.70819875405;9774.902250977399;9788.706338809847;9824.4105353679;9924.354916930377;9968.252381071594;10134.290599657954;10158.89841101609;7636.961815190888;7650.31147196755;7683.193264707349;7698.03774528184;7700.037495313086;8033.718819841278;8202.38482113832;8261.710840120568;8454.027786804596;8525.74422767318;7622.885656715264;7704.2432708856895;7794.844103118019;7817.804554885945;7960.920390796249;7748.65131069092;7769.300762931363;7810.765677029698;7849.529028258323;7857.2928436441;7076.752313668997;7189.71241150369;7193.784186474414;7201.459890508338;7203.783886483414;4010.7794071326357;5063.772130254221;5159.380874295109;5176.689398635944;5178.792848286026;4944.3572335596145;5057.14028615129;5060.063888180698;5063.974680126576;5187.19598462239 03:23:58 INFO - PROCESS | 10945 | |4;prototype.html;350.3570947311683;353.5315706688638;353.9472053538233;355.07502954802754;367.0401899034025;6331.430171284578;6363.840903977397;6386.425221730049;6390.360963903608;6437.066625339335;6374.490040796737;6385.808425747224;6389.0097034959535;6391.616503009823;6401.679916004205;4589.128065667529;4700.788464519088;4770.594499467532;4820.614350851941;4852.733099679516;4803.303520989454;4834.371531700874;4834.9033019339595;4847.927281090769;4849.175640141185;4786.449558300787;4797.904041919177;4801.61587073035;4808.783604737795;4868.56182943535;4594.58648721615;4702.670813043088;4779.832705855313;4786.617070634341;4797.0645724083815;4228.5982831630945;4230.17511585241;4231.217224813388;4274.29474136767;4274.380214868857;6124.448799608057;6128.724207410677;6130.019196928514;6145.078238264251;6145.8156255312415;5681.545476361923;5687.289088863892;5688.772449102031;5690.743916523725;5691.971540142315;6581.703823327914;6725.495587830932;6731.057651928734;6731.461483081342;6732.663366831639;4767.213409787381;4790.353302304214;4793.32893394925;4798.448178459452;4798.808047678089;6954.826129346807;6994.790156295268;7000.404965577932;7000.7549735759;7014.088168538108;4665.136949664323;4806.975965120152;4885.316055752198;4885.5847252983895;4885.926711099336;4856.611471082305;4871.464138944713;4877.170880950176;4879.39007624047;4884.65807393479;5623.128415095667;5623.943760562342;5625.071863142617;5626.071698169838;5633.8309850704545;6762.526623136431;6766.391024807791;6767.424768894601;6773.424258937947;6777.085093512412;1678.7817583714284;1705.8379453951854;1706.223668230952;1706.3430579227088;1709.9743503847453;1033.2302434686208;1069.7806949575318;1082.783443311341;1112.4326593437406;1114.4594871487323;6462.903056454157;6476.384743449365;6536.575122617015;6563.573367731082;6566.704498297588;6913.239543650195;6915.446764258948;6916.6541672916155;6920.446364290845;6929.930700692928;6526.477881769447;6530.216374035146;6530.640814755139;6554.967225163844;6555.704993275314;3704.7777133372083;3735.1969326594367;3741.7567858089683;3746.9063273418383;3747.3816820224356;6732.697028633724;6887.483438742114;7090.432765378758;7094.432445404355;7294.088238970129;7130.108736407949;7137.964310178416;7145.714171433188;7155.105611798525;7163.1404231491515;7279.563226206445;7292.8906066409045;7313.670884810196;7315.122185337794;7316.268373162641;7008.088948436671;7012.298770122947;7015.6842942066705;7019.5788252705;7027.789166325018;6776.93223067763;6890.931090689029;6901.861962760817;6905.205901321412;6907.102076729993;7306.086739157606;7331.340179383881;7331.74338898136;7338.302861228175;7342.449316301406;4781.13939490895;4806.759662016815;4823.927641085456;4829.420469543677;4832.395950506187;6996.300369962963;7001.439884809101;7001.789946301619;7009.614471204132;7012.403945664676;6506.674666266573;6786.93213067863;6788.355106264897;6792.796216113525;6798.388145066968;6624.138861947916;6704.597724136567;6715.4963377747845;6800.727970881109;6823.93176068233;6544.247411547733;6682.3317668232785;6695.363940425652;6695.531312808057;6699.866002679822;6831.248562658203;6832.726690932506;6846.554973926679;6852.074969879002;6853.7943861684225;6514.3811337922825;6634.270230274762;6638.701258443478;6638.966805165944;6650.534462587572 03:23:58 INFO - PROCESS | 10945 | |5;yui.html;863.6631713631681;911.4349103555794;921.1847514949268;929.7950292108129;930.3859452761179;14333.283335833206;14474.710505789877;14481.058731182493;14527.491537796166;14572.271386430675;14527.491537796179;14650.706985860277;14666.04670696404;14719.337629806658;14734.63163420915;745.7017193122767;899.95050272235;914.085914085914;917.334932174175;919.0350132361027;885.8184072265202;893.7988952485704;897.2821742605922;897.6992707443014;898.2230370729304;937.6483818568037;941.9105185007413;944.8299306124894;945.1965829045291;949.8480243161096;780.9531428114332;923.4966943016005;939.0937745075967;940.3323640215456;946.6875930942807;686.5949090036852;686.7699320727562;686.8454597715524;692.2869444472202;697.0972590495321;14139.434422623082;14184.219867907364;14186.858131418658;14188.574342769733;14191.574252772434;13425.127366721132;13707.931460342734;13747.243901585409;13842.031057825956;13869;11638.70903227426;11767.41162941858;12037.819432708517;12066.638000859988;12097.818532722016;4005.7796821174825;4015.7992100395154;4055.7160998729805;4059.188162367538;4098.016476045727;60696.393036069516;60874.391256087314;60922.69538652323;61108;61666.69166654183;11244.381559014333;11445.427728613537;11458.656240312805;11577.363245021435;11949.64151075469;20404.693929591067;20464.488387790127;20564.38306850797;20569;20617.89691051565;8768.473891566526;8955.149260820212;8961.462312261285;8969.50667713282;9090.818183636422;5085.542301192911;5140.228965655182;5212.921806172911;5230.08473517133;5282.339707536558;3502.7372947029075;3560.626134255918;3573.3746594346408;3590.9461358079648;3599.3341231872187;633.5786701843315;689.7516893918186;700.2682197104039;700.8282970672116;701.5124488480457;713.2439614009063;827.7392621324263;831.7005877883956;854.4189950833493;855.5722138930535;9290.628374865066;9406.38858474197;9925.65260215889;9941.80116397668;10093.899061009442;726.498715886037;764.6444403352357;793.5794029164553;805.4643661964728;829.1998221716073;4469.687121901436;4746.833860814855;4780.880477988008;4782.736949467743;4821.710697358169;57008;58703.41296587065;58871.41128588745;58984.41015589875;65838.67080664566;55418;55759;56622.71688641531;58305.416945830846;58332.41667583355;51891.22163167556;51923.48076519262;52500.21249681334;52614.21078683823;53099.46900530945;9890.45602491841;10006.649767258112;10010.899891000996;10086.949565252127;10147;37565.812170940066;38613.22773544457;39526;40090.599094008685;40186;46540;47246.76376618095;50607;51291.2306315413;52392;11842.11184161174;12162.635120946386;13006.154599950973;13155.276459794803;13297.468101275841;13087.869121309046;13444.126131801402;13572.93213533926;13582.59252222435;13909.582712518235;13028.348582570645;13603.251821149932;13784.104033237807;13876.72246555043;14058.718825623635;12784.87215127874;13175.60473185806;13303.66740831487;13400.865991339962;14353.712925741636;13076.084674072723;13325.933370333087;13650.317484125953;14107.365168567645;14116.647083822576;11039.172062095215;11307.151963602928;11497;11608.535658573901;12000.459979301128;10180.236482263712;10905.400202988912;10907.672769816918;10958.616448424267;10988.945055274673 03:23:58 INFO - PROCESS | 10945 | __end_tp_report 03:23:58 INFO - PROCESS | 10945 | __start_cc_report 03:23:58 INFO - PROCESS | 10945 | _x_x_mozilla_cycle_collect,851 03:23:58 INFO - PROCESS | 10945 | __end_cc_report 03:23:58 INFO - PROCESS | 10945 | __startTimestamp1466504638922__endTimestamp 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | ------- Summary: start ------- 03:23:58 INFO - PROCESS | 10945 | Number of tests: 6 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | [#0] dojo.html Cycles:165 Average:5555.00 Median:5760.68 stddev:616.00 (10.7%) stddev-sans-first:591.47 03:23:58 INFO - PROCESS | 10945 | Values: 3279.9 3372.6 3377.9 3405.1 3422.1 5607.2 5611.0 5613.8 5624.2 5625.0 5606.7 5625.6 5636.7 5640.1 5645.2 4901.1 5090.1 5178.1 5207.7 5243.9 5079.0 5112.2 5148.5 5155.5 5158.8 5127.3 5133.2 5191.6 5221.9 5222.1 5164.9 5166.1 5167.4 5168.1 5196.1 4862.8 5048.4 5051.5 5074.7 5114.6 5390.1 5422.2 5453.5 5469.6 5474.7 5957.2 5967.0 5969.1 5974.0 5976.6 5896.4 6008.5 6055.0 6075.6 6078.8 5570.2 5596.7 5622.8 5622.8 5631.6 6040.9 6110.2 6115.4 6122.0 6123.7 5840.3 5890.1 5900.9 5914.0 5928.0 5952.1 5959.7 5966.2 5966.4 5970.4 5875.6 5905.0 5928.3 5936.5 5943.7 5955.2 5995.1 5996.8 5999.9 6043.4 4542.6 4546.1 4546.8 4548.9 4573.7 3986.9 4040.9 4041.9 4067.4 4113.7 5773.4 5785.5 5786.9 5793.2 5831.7 6017.0 6051.1 6060.8 6063.0 6072.7 5578.9 5612.6 5707.4 5776.2 5784.6 5050.5 5057.3 5061.7 5062.1 5086.8 6303.0 6326.1 6326.1 6330.8 6332.1 5935.1 6015.6 6080.2 6085.6 6117.3 6032.5 6038.2 6072.2 6076.7 6094.1 5754.0 5758.9 5759.7 5760.7 5786.2 5846.2 5891.6 5967.3 6047.3 6066.5 5799.2 5803.4 5804.8 5808.4 5808.6 5748.2 5814.2 5814.5 5815.0 5815.1 5694.6 5778.6 5815.7 5839.3 5844.5 5734.6 5740.3 5752.8 5756.1 5772.3 5608.8 5613.1 5613.4 5613.7 5668.7 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | [#1] ext.html Cycles:180 Average:49466.88 Median:3663.88 stddev:87769.38 (2395.5%) stddev-sans-first:87938.91 03:23:58 INFO - PROCESS | 10945 | Values: 600.9 661.1 662.3 667.8 667.8 33011.8 33578.7 33603.5 33644.3 33647.5 34441.5 41869.4 42713.8 42733.6 42792.0 8810.1 8983.2 8987.5 8989.4 8992.5 8347.9 8734.3 8841.1 10759.8 11062.9 10671.7 10759.2 10770.2 10771.7 10777.7 10606.6 10680.0 10685.7 10689.4 10697.6 10430.6 10514.2 10521.3 10569.3 10576.9 40183.4 40467.8 44931.3 44938.0 44942.6 3677.4 3743.6 3765.4 3796.5 3873.8 34394.1 34816.5 34838.0 34868.7 35022.3 4607.4 4661.3 4679.4 4715.2 4826.6 219626.0 220768.0 221445.0 221522.0 221683.9 39885.6 40557.8 40614.0 65476.3 65563.0 37994.8 38009.8 38114.2 38121.4 38125.0 16847.2 17038.3 17056.6 17072.0 17079.7 14369.2 14407.9 14411.9 14431.1 14449.8 8880.1 9364.9 9593.1 9593.6 9612.6 3560.9 3650.4 3679.1 3691.2 3703.5 1063.5 1063.9 1122.4 1129.5 1130.8 33486.7 33572.2 34044.3 34251.8 34284.8 1212.7 1227.9 1232.2 1292.7 1336.6 17702.9 17901.5 17946.6 18109.6 18209.7 438296.0 443111.0 443963.0 444055.0 445557.0 62813.7 63527.0 63586.4 63591.7 63621.7 1367.9 1422.9 1522.6 1526.8 1535.3 30544.0 31133.4 32925.8 33237.7 34001.3 52103.2 52310.7 52642.7 52644.2 52667.5 294874.0 295087.0 295670.0 295859.0 296394.0 27437.0 31304.8 31664.8 31665.5 31753.0 48287.8 50080.5 50620.2 50967.2 51825.0 41025.4 41426.4 41532.6 41851.0 42412.0 39466.0 40483.8 40787.4 41406.4 42087.8 41725.0 42535.8 42824.8 43407.8 43623.3 35613.6 37130.4 37196.4 37921.4 38116.0 28500.9 28587.4 28717.7 28901.7 28960.1 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | [#2] jquery.html Cycles:180 Average:28280.52 Median:23468.30 stddev:81042.94 (345.3%) stddev-sans-first:81243.29 03:23:58 INFO - PROCESS | 10945 | Values: 422.8 424.8 435.9 440.8 441.5 18557.0 18576.5 18772.4 19270.9 19369.2 18421.2 18606.2 19402.9 19493.2 19547.1 5575.0 5577.5 5751.4 5795.2 5805.0 5705.4 5762.6 5770.9 5782.6 5799.0 5510.9 5733.1 5734.9 5741.4 5763.0 5703.9 5727.5 5745.1 5754.6 5760.9 5098.1 5118.4 5120.3 5141.8 5194.6 23466.4 23470.2 23773.8 24130.3 24201.3 2431.4 2485.8 2829.8 3264.9 3287.8 10180.3 13450.6 13556.4 13928.4 14128.9 2019.8 2056.9 2067.6 2077.7 2154.7 74837.6 76656.6 78802.0 79617.6 80803.2 10728.2 10915.6 11182.4 11198.9 11323.4 15266.1 15469.8 15713.7 15746.2 15810.4 8563.7 8620.9 8626.0 9016.2 9028.9 8863.4 8894.4 8901.9 9014.5 9039.1 6744.9 6780.9 6825.9 6895.7 6932.5 2015.5 2017.2 2020.8 2062.1 2071.5 1013.5 1081.3 1100.6 1141.6 1152.5 18867.8 20056.8 20135.9 20412.7 20582.9 1121.8 1131.8 1159.5 1167.8 1189.8 11395.8 11424.5 11433.0 11464.4 11642.4 477494.5 479205.0 503501.0 504850.0 512544.0 49277.5 49513.8 65323.7 69453.3 84961.0 1107.7 1114.1 1134.4 1139.6 1152.2 13292.5 16928.6 17279.2 17451.3 17771.9 34840.7 36816.0 37005.4 38158.6 38957.8 49102.3 49715.0 49795.0 50004.0 50135.5 9274.1 9390.7 9421.1 9468.0 9483.8 13189.5 13984.5 14116.4 14200.3 14239.3 11852.2 12169.4 12177.9 12405.7 12729.6 12049.6 12057.1 12080.4 12225.4 12361.6 12173.2 12251.5 12299.3 12433.9 12597.7 8581.6 8810.6 8826.5 8937.2 8953.1 11068.7 12098.0 12123.4 12190.2 12243.2 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | [#3] mootools.html Cycles:180 Average:5797.10 Median:4754.20 stddev:3258.59 (68.5%) stddev-sans-first:3251.26 03:23:58 INFO - PROCESS | 10945 | Values: 1436.4 1557.9 1590.9 1804.5 1937.9 7835.8 8527.6 8639.5 8641.6 8652.1 8435.8 8613.6 8615.7 8629.8 8648.8 2116.2 2128.1 2135.2 2138.8 2141.6 2367.1 2399.1 2428.1 2430.6 2443.0 2405.4 2423.5 2434.2 2463.6 2464.3 2377.0 2408.1 2409.2 2409.7 2446.2 2282.9 2380.5 2393.8 2393.8 2394.6 7615.3 8290.8 8768.3 8832.4 8835.0 5241.7 5355.5 5362.4 5364.4 5366.1 3497.4 3497.6 3501.1 3505.6 3577.6 1095.3 1096.8 1109.3 1112.8 1113.7 11931.5 12362.2 12375.5 12381.8 12386.8 4624.1 4637.8 4734.7 4749.1 4759.4 10574.2 10649.9 10655.6 10661.1 10705.9 5487.0 5515.3 5515.5 5516.1 5528.0 4919.0 4987.6 4991.0 5000.4 5004.7 3921.8 4010.2 4044.3 4045.5 4059.5 1197.5 1202.1 1209.2 1217.2 1223.8 1035.3 1041.8 1048.0 1051.1 1067.5 5824.8 5828.9 5910.1 6097.3 6137.4 989.5 1048.2 1076.0 1078.0 1086.9 3889.3 3916.2 3993.3 4031.7 4034.8 10597.9 10933.8 11035.2 11107.6 11121.9 10746.2 10933.5 10938.7 10939.1 10941.2 8310.4 8441.9 8491.7 8545.8 8548.4 5593.1 5666.8 5693.4 5758.9 5866.6 9422.6 9500.2 9726.7 9774.9 9788.7 9824.4 9924.4 9968.3 10134.3 10158.9 7637.0 7650.3 7683.2 7698.0 7700.0 8033.7 8202.4 8261.7 8454.0 8525.7 7622.9 7704.2 7794.8 7817.8 7960.9 7748.7 7769.3 7810.8 7849.5 7857.3 7076.8 7189.7 7193.8 7201.5 7203.8 4010.8 5063.8 5159.4 5176.7 5178.8 4944.4 5057.1 5060.1 5064.0 5187.2 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | [#4] prototype.html Cycles:180 Average:5652.85 Median:6469.64 stddev:1714.27 (26.5%) stddev-sans-first:1672.24 03:23:58 INFO - PROCESS | 10945 | Values: 350.4 353.5 353.9 355.1 367.0 6331.4 6363.8 6386.4 6390.4 6437.1 6374.5 6385.8 6389.0 6391.6 6401.7 4589.1 4700.8 4770.6 4820.6 4852.7 4803.3 4834.4 4834.9 4847.9 4849.2 4786.4 4797.9 4801.6 4808.8 4868.6 4594.6 4702.7 4779.8 4786.6 4797.1 4228.6 4230.2 4231.2 4274.3 4274.4 6124.4 6128.7 6130.0 6145.1 6145.8 5681.5 5687.3 5688.8 5690.7 5692.0 6581.7 6725.5 6731.1 6731.5 6732.7 4767.2 4790.4 4793.3 4798.4 4798.8 6954.8 6994.8 7000.4 7000.8 7014.1 4665.1 4807.0 4885.3 4885.6 4885.9 4856.6 4871.5 4877.2 4879.4 4884.7 5623.1 5623.9 5625.1 5626.1 5633.8 6762.5 6766.4 6767.4 6773.4 6777.1 1678.8 1705.8 1706.2 1706.3 1710.0 1033.2 1069.8 1082.8 1112.4 1114.5 6462.9 6476.4 6536.6 6563.6 6566.7 6913.2 6915.4 6916.7 6920.4 6929.9 6526.5 6530.2 6530.6 6555.0 6555.7 3704.8 3735.2 3741.8 3746.9 3747.4 6732.7 6887.5 7090.4 7094.4 7294.1 7130.1 7138.0 7145.7 7155.1 7163.1 7279.6 7292.9 7313.7 7315.1 7316.3 7008.1 7012.3 7015.7 7019.6 7027.8 6776.9 6890.9 6901.9 6905.2 6907.1 7306.1 7331.3 7331.7 7338.3 7342.4 4781.1 4806.8 4823.9 4829.4 4832.4 6996.3 7001.4 7001.8 7009.6 7012.4 6506.7 6786.9 6788.4 6792.8 6798.4 6624.1 6704.6 6715.5 6800.7 6823.9 6544.2 6682.3 6695.4 6695.5 6699.9 6831.2 6832.7 6846.6 6852.1 6853.8 6514.4 6634.3 6638.7 6639.0 6650.5 03:23:58 INFO - PROCESS | 10945 | 03:23:58 INFO - PROCESS | 10945 | [#5] yui.html Cycles:180 Average:15639.36 Median:25504.84 stddev:17940.85 (70.3%) stddev-sans-first:17956.87 03:23:58 INFO - PROCESS | 10945 | Values: 863.7 911.4 921.2 929.8 930.4 14333.3 14474.7 14481.1 14527.5 14572.3 14527.5 14650.7 14666.0 14719.3 14734.6 745.7 900.0 914.1 917.3 919.0 885.8 893.8 897.3 897.7 898.2 937.6 941.9 944.8 945.2 949.8 781.0 923.5 939.1 940.3 946.7 686.6 686.8 686.8 692.3 697.1 14139.4 14184.2 14186.9 14188.6 14191.6 13425.1 13707.9 13747.2 13842.0 13869.0 11638.7 11767.4 12037.8 12066.6 12097.8 4005.8 4015.8 4055.7 4059.2 4098.0 60696.4 60874.4 60922.7 61108.0 61666.7 11244.4 11445.4 11458.7 11577.4 11949.6 20404.7 20464.5 20564.4 20569.0 20617.9 8768.5 8955.1 8961.5 8969.5 9090.8 5085.5 5140.2 5212.9 5230.1 5282.3 3502.7 3560.6 3573.4 3590.9 3599.3 633.6 689.8 700.3 700.8 701.5 713.2 827.7 831.7 854.4 855.6 9290.6 9406.4 9925.7 9941.8 10093.9 726.5 764.6 793.6 805.5 829.2 4469.7 4746.8 4780.9 4782.7 4821.7 57008.0 58703.4 58871.4 58984.4 65838.7 55418.0 55759.0 56622.7 58305.4 58332.4 51891.2 51923.5 52500.2 52614.2 53099.5 9890.5 10006.6 10010.9 10086.9 10147.0 37565.8 38613.2 39526.0 40090.6 40186.0 46540.0 47246.8 50607.0 51291.2 52392.0 11842.1 12162.6 13006.2 13155.3 13297.5 13087.9 13444.1 13572.9 13582.6 13909.6 13028.3 13603.3 13784.1 13876.7 14058.7 12784.9 13175.6 13303.7 13400.9 14353.7 13076.1 13325.9 13650.3 14107.4 14116.6 11039.2 11307.2 11497.0 11608.5 12000.5 10180.2 10905.4 10907.7 10958.6 10988.9 03:23:58 INFO - PROCESS | 10945 | -------- Summary: end -------- 03:23:58 INFO - PROCESS | 10945 | 03:23:59 INFO - TEST-INFO | 10945: exit 0 03:23:59 INFO - TEST-OK | dromaeo_css | took 1110715ms 03:23:59 INFO - TEST-START | kraken 03:23:59 INFO - operating with platform_type : linux_ 03:23:59 INFO - Initialising browser for kraken test... 03:23:59 INFO - TEST-INFO | started process 11146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGqqCu8/profile http://localhost:50971/getInfo.html) 03:24:03 INFO - PROCESS | 11146 | __metrics Screen width/height:1600/1200 03:24:03 INFO - PROCESS | 11146 | colorDepth:24 03:24:03 INFO - PROCESS | 11146 | Browser inner width/height: 1024/697 03:24:03 INFO - PROCESS | 11146 | __metrics 03:24:04 ERROR - PROCESS | 11146 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:24:05 INFO - TEST-INFO | 11146: exit 0 03:24:05 INFO - Browser initialized. 03:24:05 INFO - Running cycle 1/1 for kraken test... 03:24:05 INFO - TEST-INFO | started process 11239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGqqCu8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:16 INFO - PROCESS | 11239 | RSS: Main: 140926976 03:24:16 INFO - PROCESS | 11239 | 03:24:19 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50971/tests/kraken/driver.html?testName=audio-beat-detection) 03:24:20 INFO - PROCESS | 11239 | RSS: Main: 197636096 03:24:20 INFO - PROCESS | 11239 | 03:24:22 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50971/tests/kraken/driver.html?testName=audio-dft) 03:24:23 INFO - PROCESS | 11239 | RSS: Main: 185393152 03:24:23 INFO - PROCESS | 11239 | 03:24:26 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50971/tests/kraken/driver.html?testName=audio-fft) 03:24:26 INFO - PROCESS | 11239 | RSS: Main: 273960960 03:24:26 INFO - PROCESS | 11239 | 03:24:28 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50971/tests/kraken/driver.html?testName=audio-oscillator) 03:24:29 INFO - PROCESS | 11239 | RSS: Main: 180453376 03:24:29 INFO - PROCESS | 11239 | 03:24:31 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50971/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:24:32 INFO - PROCESS | 11239 | RSS: Main: 178872320 03:24:32 INFO - PROCESS | 11239 | 03:24:35 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50971/tests/kraken/driver.html?testName=imaging-darkroom) 03:24:35 INFO - PROCESS | 11239 | RSS: Main: 213651456 03:24:35 INFO - PROCESS | 11239 | 03:24:39 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50971/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:39 INFO - PROCESS | 11239 | RSS: Main: 213512192 03:24:39 INFO - PROCESS | 11239 | 03:24:42 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50971/tests/kraken/driver.html?testName=json-parse-financial) 03:24:43 INFO - PROCESS | 11239 | RSS: Main: 213553152 03:24:43 INFO - PROCESS | 11239 | 03:24:44 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50971/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:24:45 INFO - PROCESS | 11239 | RSS: Main: 191873024 03:24:45 INFO - PROCESS | 11239 | 03:24:46 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:24:47 INFO - PROCESS | 11239 | RSS: Main: 196304896 03:24:47 INFO - PROCESS | 11239 | 03:24:49 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:50 INFO - PROCESS | 11239 | RSS: Main: 209977344 03:24:50 INFO - PROCESS | 11239 | 03:24:52 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:53 INFO - PROCESS | 11239 | RSS: Main: 217550848 03:24:53 INFO - PROCESS | 11239 | 03:24:55 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:56 INFO - PROCESS | 11239 | RSS: Main: 211996672 03:24:56 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:50971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50971/tests/kraken/driver.html?testName=ai-astar) 03:24:58 INFO - PROCESS | 11239 | RSS: Main: 272900096 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | __start_tp_report 03:24:58 INFO - PROCESS | 11239 | _x_x_mozilla_page_load 03:24:58 INFO - PROCESS | 11239 | _x_x_mozilla_page_load_details 03:24:58 INFO - PROCESS | 11239 | |i|pagename|runs| 03:24:58 INFO - PROCESS | 11239 | |0;ai-astar;110;110;110;110;111;109;104;109;109;109 03:24:58 INFO - PROCESS | 11239 | |1;audio-beat-detection;157;127;164;185;133;163;159;128;176;125 03:24:58 INFO - PROCESS | 11239 | |2;audio-dft;162;161;163;160;162;160;161;161;160;160 03:24:58 INFO - PROCESS | 11239 | |3;audio-fft;75;76;79;166;77;73;78;74;163;75 03:24:58 INFO - PROCESS | 11239 | |4;audio-oscillator;91;91;165;91;91;92;146;91;93;141 03:24:58 INFO - PROCESS | 11239 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;117;117 03:24:58 INFO - PROCESS | 11239 | |6;imaging-darkroom;146;146;145;145;145;146;146;145;145;145 03:24:58 INFO - PROCESS | 11239 | |7;imaging-desaturate;94;95;95;94;94;95;94;95;95;94 03:24:58 INFO - PROCESS | 11239 | |8;json-parse-financial;55;56;55;55;54;54;56;74;53;52 03:24:58 INFO - PROCESS | 11239 | |9;json-stringify-tinderbox;58;59;59;59;59;59;59;59;60;60 03:24:58 INFO - PROCESS | 11239 | |10;stanford-crypto-aes;72;72;77;79;74;74;75;77;73;73 03:24:58 INFO - PROCESS | 11239 | |11;stanford-crypto-ccm;119;114;114;115;111;114;111;114;129;117 03:24:58 INFO - PROCESS | 11239 | |12;stanford-crypto-pbkdf2;160;159;157;156;165;160;162;159;162;160 03:24:58 INFO - PROCESS | 11239 | |13;stanford-crypto-sha256-iterative;68;66;67;65;64;66;67;66;65;72 03:24:58 INFO - PROCESS | 11239 | __end_tp_report 03:24:58 INFO - PROCESS | 11239 | __start_cc_report 03:24:58 INFO - PROCESS | 11239 | _x_x_mozilla_cycle_collect,1565 03:24:58 INFO - PROCESS | 11239 | __end_cc_report 03:24:58 INFO - PROCESS | 11239 | __startTimestamp1466504698300__endTimestamp 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | ------- Summary: start ------- 03:24:58 INFO - PROCESS | 11239 | Number of tests: 14 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 03:24:58 INFO - PROCESS | 11239 | Values: 110.0 110.0 110.0 110.0 111.0 109.0 104.0 109.0 109.0 109.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:161.00 stddev:21.84 (13.6%) stddev-sans-first:23.08 03:24:58 INFO - PROCESS | 11239 | Values: 157.0 127.0 164.0 185.0 133.0 163.0 159.0 128.0 176.0 125.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 03:24:58 INFO - PROCESS | 11239 | Values: 162.0 161.0 163.0 160.0 162.0 160.0 161.0 161.0 160.0 160.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.50 stddev:37.42 (49.6%) stddev-sans-first:39.08 03:24:58 INFO - PROCESS | 11239 | Values: 75.0 76.0 79.0 166.0 77.0 73.0 78.0 74.0 163.0 75.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:91.00 stddev:29.24 (32.1%) stddev-sans-first:30.26 03:24:58 INFO - PROCESS | 11239 | Values: 91.0 91.0 165.0 91.0 91.0 92.0 146.0 91.0 93.0 141.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:24:58 INFO - PROCESS | 11239 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:24:58 INFO - PROCESS | 11239 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:24:58 INFO - PROCESS | 11239 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:55.00 stddev:6.31 (11.5%) stddev-sans-first:6.67 03:24:58 INFO - PROCESS | 11239 | Values: 55.0 56.0 55.0 55.0 54.0 54.0 56.0 74.0 53.0 52.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 03:24:58 INFO - PROCESS | 11239 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.50 stddev:2.37 (3.2%) stddev-sans-first:2.32 03:24:58 INFO - PROCESS | 11239 | Values: 72.0 72.0 77.0 79.0 74.0 74.0 75.0 77.0 73.0 73.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:114.50 stddev:5.22 (4.6%) stddev-sans-first:5.41 03:24:58 INFO - PROCESS | 11239 | Values: 119.0 114.0 114.0 115.0 111.0 114.0 111.0 114.0 129.0 117.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.00 stddev:2.58 (1.6%) stddev-sans-first:2.74 03:24:58 INFO - PROCESS | 11239 | Values: 160.0 159.0 157.0 156.0 165.0 160.0 162.0 159.0 162.0 160.0 03:24:58 INFO - PROCESS | 11239 | 03:24:58 INFO - PROCESS | 11239 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.22 (3.3%) stddev-sans-first:2.30 03:24:58 INFO - PROCESS | 11239 | Values: 68.0 66.0 67.0 65.0 64.0 66.0 67.0 66.0 65.0 72.0 03:24:58 INFO - PROCESS | 11239 | -------- Summary: end -------- 03:24:58 INFO - PROCESS | 11239 | 03:24:59 INFO - TEST-INFO | 11239: exit 0 03:24:59 INFO - TEST-OK | kraken | took 59623ms 03:24:59 INFO - SUITE-END | took 1170s 03:24:59 INFO - Completed test suite (00:19:30) 03:24:59 INFO - javascript benchmark 03:24:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.918002049949, 3372.6121496027963, 3377.8817741379057, 3405.0976491229812, 3422.0760394693434, 5607.158926161078, 5611.046122159238, 5613.775448982046, 5624.184493248476, 5624.971875140619, 5606.719664016793, 5625.634333768302, 5636.689982050985, 5640.0693885508945, 5645.2096706461125, 4901.142300097486, 5090.134677104892, 5178.093833579127, 5207.713575753332, 5243.86890327741, 5079.03498335317, 5112.233165025257, 5148.485151484859, 5155.4586768389345, 5158.819441319554, 5127.256547800566, 5133.178691409356, 5191.610629202806, 5221.921671174935, 5222.112240919034, 5164.922526162091, 5166.07010738067, 5167.431582525919, 5168.069747445458, 5196.142636464979, 4862.756862156878, 5048.368953880765, 5051.469595692436, 5074.746262686851, 5114.565261952738, 5390.110631745757, 5422.186671999192, 5453.481919217668, 5469.644473109235, 5474.671519708831, 5957.165996760457, 5967.045272756382, 5969.134475501071, 5973.970130149365, 5976.611520251213, 5896.410358964112, 6008.549358798107, 6055.031195008777, 6075.605085669417, 6078.787242446538, 5570.192322113311, 5596.720163991784, 5622.803201887914, 5622.831315060595, 5631.5776316776, 6040.939590604038, 6110.175126357974, 6115.449609535163, 6121.969390153021, 6123.663198524035, 5840.269966254218, 5890.057590785454, 5900.881982360329, 5914.0, 5928.0, 5952.136940143655, 5959.702014899238, 5966.194563733927, 5966.433188847052, 5970.402959704082, 5875.6180848245585, 5905.0, 5928.258967629046, 5936.5250779937505, 5943.673097979567, 5955.166276721263, 5995.070764031582, 5996.760129594767, 5999.850003749942, 6043.395660433922, 4542.613877820422, 4546.1135078659345, 4546.818127274938, 4548.931766023512, 4573.748443835554, 3986.86045988389, 4040.939385909214, 4041.9191616167514, 4067.4102255173425, 4113.71204015722, 5773.39379365169, 5785.537157027427, 5786.855328616818, 5793.159991801165, 5831.679257640785, 6017.0, 6051.122587224916, 6060.848478788065, 6063.029915213633, 6072.726727297282, 5578.860528486739, 5612.635178713371, 5707.429257074343, 5776.220210271644, 5784.566157538202, 5050.4697006814495, 5057.342545469065, 5061.6962982221185, 5062.063518249136, 5086.77109530072, 6302.968485157637, 6326.082718005863, 6326.145970294044, 6330.778422755181, 6332.0818481320875, 5935.109733540004, 6015.639061656315, 6080.209572755513, 6085.57400981927, 6117.265928088658, 6032.487238584769, 6038.184845045863, 6072.180255665606, 6076.6961651916345, 6094.11635312886, 5754.0, 5758.884822303614, 5759.65442073477, 5760.683162426107, 5786.247787787561, 5846.210761547137, 5891.617044892068, 5967.283925928917, 6047.304559975659, 6066.545009124245, 5799.188113664175, 5803.361630220588, 5804.82585522435, 5808.419158084158, 5808.5643576732755, 5748.223989761496, 5814.215080964185, 5814.505767009851, 5815.04051831443, 5815.127730840408, 5694.572907032072, 5778.566607504538, 5815.738291776795, 5839.270091238595, 5844.503217226584, 5734.627249228787, 5740.253767010262, 5752.7698892043845, 5756.0502517084215, 5772.307323121252, 5608.831735047955, 5613.101903695389, 5613.354464236501, 5613.663180209201, 5668.7165641718575], "value": 5514.996726097032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9008513595257, 661.0579923608856, 662.3145044878552, 667.7762949411947, 667.8497338098929, 33011.83494082529, 33578.66421335786, 33603.49594756075, 33644.327113457715, 33647.49528757071, 34441.48337774929, 41869.371959420554, 42713.7864310678, 42733.57266427335, 42792.0, 8810.07494213108, 8983.19151276385, 8987.505687187202, 8989.415687980292, 8992.505412202327, 8347.874781878276, 8734.301255899545, 8841.115888411172, 10759.83860242097, 11062.889371106266, 10671.733206669856, 10759.193060520452, 10770.192235582323, 10771.730706732316, 10777.730556736105, 10606.628767993121, 10680.0, 10685.679429617046, 10689.358638481639, 10697.572097116106, 10430.634927777568, 10514.158867290598, 10521.316114452537, 10569.312994655324, 10576.947115264451, 40183.397249041285, 40467.7976610118, 44931.32603010957, 44938.0, 44942.55057449449, 3677.3748462761396, 3743.625637436262, 3765.435184722286, 3796.54441467023, 3873.845046198149, 34394.14014649629, 34816.47775283373, 34838.0, 34868.65131348705, 35022.29955400878, 4607.4471063472265, 4661.347411362412, 4679.438467383936, 4715.245560710304, 4826.565609095198, 219626.0, 220768.0, 221445.0, 221522.0, 221683.89158054267, 39885.601143988766, 40557.797211013756, 40614.0, 65476.34523654702, 65563.0, 37994.81002594969, 38009.80995095007, 38114.23771524554, 38121.42817857734, 38125.0, 16847.241874115694, 17038.31846726142, 17056.57358566046, 17072.0, 17079.743803842954, 14369.209693466959, 14407.92796036034, 14411.92794036023, 14431.134131952116, 14449.78325325121, 8880.111988801198, 9364.906350936404, 9593.088656577615, 9593.568289426992, 9612.615495380247, 3560.8812756409893, 3650.393826716236, 3679.0802299425145, 3691.1694868654877, 3703.5370578677666, 1063.505469956474, 1063.9308444951052, 1122.4331712485143, 1129.497373668726, 1130.8077626803463, 33486.66513334835, 33572.1606959828, 34044.31911361759, 34251.82874085614, 34284.82857585746, 1212.7331986962854, 1227.8526576810839, 1232.2298563397876, 1292.6768307923019, 1336.565616174747, 17702.911485442746, 17901.462956111336, 17946.64106717858, 18109.63780724378, 18209.7268540972, 438296.0, 443111.0, 443963.0, 444055.0, 445557.0, 62813.68593157005, 63527.04709429362, 63586.36413635897, 63591.6820415895, 63621.68189159025, 1367.9110857794212, 1422.8972546276718, 1522.596511924341, 1526.778617100514, 1535.3091109000993, 30544.0, 31133.377332453678, 32925.83537082299, 33237.667623323454, 34001.31997360088, 52103.21845172401, 52310.73844630752, 52642.73678631582, 52644.21033684421, 52667.473325266255, 294874.0, 295087.0, 295670.0, 295859.0, 296394.0, 27437.0, 31304.843475782476, 31664.841675791475, 31665.525017124302, 31753.0, 48287.75856120697, 50080.499195007586, 50620.24069639032, 50967.23549146692, 51825.0, 41025.384619230135, 41426.37860432156, 41532.58467415287, 41851.0, 42412.0, 39466.0, 40483.79758101191, 40787.38818917659, 41406.378904315854, 42087.789561052, 41725.0, 42535.787321063195, 42824.78587607042, 43407.78296108625, 43623.34564981464, 35613.64386356103, 37130.44304335491, 37196.44205336868, 37921.43117853179, 38116.0, 28500.85749571239, 28587.42825143527, 28717.71282287234, 28901.71098289074, 28960.13119606415], "value": 19290.45856954628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.8012833968034, 424.84705506017826, 435.92589259825826, 440.825873779857, 441.5385921711811, 18557.0, 18576.535586610342, 18772.43682689518, 19270.903645481787, 19369.22523099076, 18421.17104730287, 18606.16272267748, 19402.90298548509, 19493.22027118917, 19547.120379582917, 5574.9721251393685, 5577.52591029763, 5751.396103409144, 5795.246617939683, 5804.970975145118, 5705.4294570543025, 5762.56780741444, 5770.942290577103, 5782.566307526931, 5798.971005144989, 5510.9448905511035, 5733.082706766918, 5734.913976290359, 5741.425857414267, 5762.971185144069, 5703.942960570383, 5727.455891690282, 5745.138229265602, 5754.625949313281, 5760.913586296209, 5098.133317336024, 5118.360204974379, 5120.334356533664, 5141.84574462763, 5194.63637545372, 23466.413339666473, 23470.17854375106, 23773.762262377328, 24130.276091717278, 24201.273961781175, 2431.367844360479, 2485.751424857518, 2829.8302101873746, 3264.934701305984, 3287.8356082195796, 10180.338278011906, 13450.596482105553, 13556.389962451713, 13928.37322320498, 14128.858711412857, 2019.8182163605345, 2056.9485762855898, 2067.58648270345, 2077.6779599162155, 2154.6983422320886, 74837.62581187114, 76656.61671691606, 78802.0, 79617.60191199007, 80803.19196808015, 10728.195385346131, 10915.617953371593, 11182.384968826793, 11198.888011119947, 11323.358113073558, 15266.084034957716, 15469.767953480707, 15713.68572628541, 15746.212689365486, 15810.446634367741, 8563.743087707378, 8620.870686939701, 8626.0, 9016.18854303116, 9028.909710902806, 8863.394182028182, 8894.377393582387, 8901.866472002925, 9014.549272536347, 9039.096090390909, 6744.898826517606, 6780.898286525706, 6825.863482730417, 6895.724171033203, 6932.480063995221, 2015.5263513074415, 2017.1729590867674, 2020.7575090988882, 2062.0823733438774, 2071.461420030803, 1013.4780587997187, 1081.2755453845941, 1100.6422912553292, 1141.594733869481, 1152.5389844062443, 18867.81132188688, 20056.799432005784, 20135.899320503304, 20412.693809592867, 20582.897085514775, 1121.775644871029, 1131.8358837968449, 1159.5361855257963, 1167.8189880568525, 1189.8155785853207, 11395.829062564067, 11424.543018279343, 11433.042299565528, 11464.36945967963, 11642.359670218219, 477494.5127469203, 479205.0, 503501.0, 504850.0, 512544.0, 49277.50722492729, 49513.75243123761, 65323.67338163279, 69453.30546694469, 84961.0, 1107.7286064914147, 1114.0975809594254, 1134.3930996916445, 1139.641013080877, 1152.1819508149308, 13292.534761283308, 16928.645708343058, 17279.22243499071, 17451.30194792194, 17771.911140444216, 34840.651593484756, 36816.0, 37005.44491832571, 38158.61841381551, 38957.80521097376, 49102.26346604875, 49715.0, 49795.0, 50004.0, 50135.49864501308, 9274.118958699182, 9390.718278451657, 9421.118012422361, 9467.952660236655, 9483.762905927408, 13189.538366157138, 13984.510542130976, 14116.364763585869, 14200.28998550089, 14239.288035597972, 11852.229605075643, 12169.39153042362, 12177.878221217674, 12405.689857753629, 12729.648321397997, 12049.638510844688, 12057.095717821023, 12080.39598020113, 12225.388730563614, 12361.567345142877, 12173.20874143178, 12251.509939602316, 12299.323537205539, 12433.93783031079, 12597.685057873627, 8581.570921454027, 8810.64757409722, 8826.514541700268, 8937.150970657776, 8953.149450802164, 11068.723281918017, 12098.0, 12123.393830308625, 12190.2076365036, 12243.20419172751], "value": 9549.694362337053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.4182506085026, 1557.9221038948053, 1590.9204539773011, 1804.4676820338, 1937.8837269763806, 7835.843283134334, 8527.635578307472, 8639.52482613456, 8641.611127499262, 8652.134786521345, 8435.789105272372, 8613.569321533929, 8615.741527754177, 8629.784255393619, 8648.783780405478, 2116.153538584567, 2128.063651993118, 2135.220644464767, 2138.764735879052, 2141.635921893274, 2367.1478267823654, 2399.1123284384803, 2428.101602407112, 2430.6232533957264, 2443.022790883643, 2405.434722840131, 2423.4789520253144, 2434.221049264227, 2463.6427717980882, 2464.322311364371, 2376.9524609507885, 2408.0969636386353, 2409.1929203716863, 2409.662647229389, 2446.217210492643, 2282.863028218312, 2380.5238952209456, 2393.8204634652297, 2393.832431729762, 2394.5570069537193, 7615.31462168402, 8290.8341833163, 8768.254698350584, 8832.425892316978, 8834.983976842681, 5241.68549887008, 5355.491228333302, 5362.436944120889, 5364.356277246717, 5366.087765079946, 3497.387957107496, 3497.615262321143, 3501.072215862798, 3505.6319086495805, 3577.5706915170085, 1095.2935356694886, 1096.780643871221, 1109.295597295715, 1112.8330750387427, 1113.6770336602376, 11931.522739090426, 12362.196457230251, 12375.504979800797, 12381.75236495265, 12386.75226495465, 4624.121416930772, 4637.791299391535, 4734.721625161187, 4749.050189962021, 4759.357486739246, 10574.206934479791, 10649.893501065046, 10655.57377704883, 10661.147108231324, 10705.9464702676, 5487.039768040577, 5515.25544051556, 5515.503604675519, 5516.14499752539, 5527.972360138254, 4919.040787046563, 4987.551120399182, 4991.026749783758, 5000.374953130859, 5004.674696144739, 3921.784301863425, 4010.2380547695843, 4044.2518134145275, 4045.5347635021762, 4059.5331536873045, 1197.5329621447643, 1202.0864143251192, 1209.195884736658, 1217.245307909102, 1223.7736018836545, 1035.3115178406426, 1041.7760181561, 1047.9895201048043, 1051.0540513537724, 1067.5036108209565, 5824.767009319579, 5828.941710582924, 5910.113482977502, 6097.298810636745, 6137.447629713347, 989.4706332112286, 1048.1614708233535, 1075.9623413180502, 1078.0405439159154, 1086.9293495922739, 3889.2999260133447, 3916.1580260244186, 3993.281209382339, 4031.737937034083, 4034.757914525138, 10597.9470102649, 10933.835992460119, 11035.2275340727, 11107.611233606785, 11121.944390278159, 10746.194035447374, 10933.507992140372, 10938.671839844657, 10939.12487001038, 10941.23411361213, 8310.376721745894, 8441.873371899426, 8491.702790402429, 8545.786355341166, 8548.358873084544, 5593.105103183471, 5666.829995100154, 5693.430656934273, 5758.942410575841, 5866.5893387464175, 9422.575984080595, 9500.192483638968, 9726.70819875405, 9774.902250977399, 9788.706338809847, 9824.4105353679, 9924.354916930377, 9968.252381071594, 10134.290599657954, 10158.89841101609, 7636.961815190888, 7650.31147196755, 7683.193264707349, 7698.03774528184, 7700.037495313086, 8033.718819841278, 8202.38482113832, 8261.710840120568, 8454.027786804596, 8525.74422767318, 7622.885656715264, 7704.2432708856895, 7794.844103118019, 7817.804554885945, 7960.920390796249, 7748.65131069092, 7769.300762931363, 7810.765677029698, 7849.529028258323, 7857.2928436441, 7076.752313668997, 7189.71241150369, 7193.784186474414, 7201.459890508338, 7203.783886483414, 4010.7794071326357, 5063.772130254221, 5159.380874295109, 5176.689398635944, 5178.792848286026, 4944.3572335596145, 5057.14028615129, 5060.063888180698, 5063.974680126576, 5187.19598462239], "value": 4672.011506184902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3570947311683, 353.5315706688638, 353.9472053538233, 355.07502954802754, 367.0401899034025, 6331.430171284578, 6363.840903977397, 6386.425221730049, 6390.360963903608, 6437.066625339335, 6374.490040796737, 6385.808425747224, 6389.0097034959535, 6391.616503009823, 6401.679916004205, 4589.128065667529, 4700.788464519088, 4770.594499467532, 4820.614350851941, 4852.733099679516, 4803.303520989454, 4834.371531700874, 4834.9033019339595, 4847.927281090769, 4849.175640141185, 4786.449558300787, 4797.904041919177, 4801.61587073035, 4808.783604737795, 4868.56182943535, 4594.58648721615, 4702.670813043088, 4779.832705855313, 4786.617070634341, 4797.0645724083815, 4228.5982831630945, 4230.17511585241, 4231.217224813388, 4274.29474136767, 4274.380214868857, 6124.448799608057, 6128.724207410677, 6130.019196928514, 6145.078238264251, 6145.8156255312415, 5681.545476361923, 5687.289088863892, 5688.772449102031, 5690.743916523725, 5691.971540142315, 6581.703823327914, 6725.495587830932, 6731.057651928734, 6731.461483081342, 6732.663366831639, 4767.213409787381, 4790.353302304214, 4793.32893394925, 4798.448178459452, 4798.808047678089, 6954.826129346807, 6994.790156295268, 7000.404965577932, 7000.7549735759, 7014.088168538108, 4665.136949664323, 4806.975965120152, 4885.316055752198, 4885.5847252983895, 4885.926711099336, 4856.611471082305, 4871.464138944713, 4877.170880950176, 4879.39007624047, 4884.65807393479, 5623.128415095667, 5623.943760562342, 5625.071863142617, 5626.071698169838, 5633.8309850704545, 6762.526623136431, 6766.391024807791, 6767.424768894601, 6773.424258937947, 6777.085093512412, 1678.7817583714284, 1705.8379453951854, 1706.223668230952, 1706.3430579227088, 1709.9743503847453, 1033.2302434686208, 1069.7806949575318, 1082.783443311341, 1112.4326593437406, 1114.4594871487323, 6462.903056454157, 6476.384743449365, 6536.575122617015, 6563.573367731082, 6566.704498297588, 6913.239543650195, 6915.446764258948, 6916.6541672916155, 6920.446364290845, 6929.930700692928, 6526.477881769447, 6530.216374035146, 6530.640814755139, 6554.967225163844, 6555.704993275314, 3704.7777133372083, 3735.1969326594367, 3741.7567858089683, 3746.9063273418383, 3747.3816820224356, 6732.697028633724, 6887.483438742114, 7090.432765378758, 7094.432445404355, 7294.088238970129, 7130.108736407949, 7137.964310178416, 7145.714171433188, 7155.105611798525, 7163.1404231491515, 7279.563226206445, 7292.8906066409045, 7313.670884810196, 7315.122185337794, 7316.268373162641, 7008.088948436671, 7012.298770122947, 7015.6842942066705, 7019.5788252705, 7027.789166325018, 6776.93223067763, 6890.931090689029, 6901.861962760817, 6905.205901321412, 6907.102076729993, 7306.086739157606, 7331.340179383881, 7331.74338898136, 7338.302861228175, 7342.449316301406, 4781.13939490895, 4806.759662016815, 4823.927641085456, 4829.420469543677, 4832.395950506187, 6996.300369962963, 7001.439884809101, 7001.789946301619, 7009.614471204132, 7012.403945664676, 6506.674666266573, 6786.93213067863, 6788.355106264897, 6792.796216113525, 6798.388145066968, 6624.138861947916, 6704.597724136567, 6715.4963377747845, 6800.727970881109, 6823.93176068233, 6544.247411547733, 6682.3317668232785, 6695.363940425652, 6695.531312808057, 6699.866002679822, 6831.248562658203, 6832.726690932506, 6846.554973926679, 6852.074969879002, 6853.7943861684225, 6514.3811337922825, 6634.270230274762, 6638.701258443478, 6638.966805165944, 6650.534462587572], "value": 5089.224894515601, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.6631713631681, 911.4349103555794, 921.1847514949268, 929.7950292108129, 930.3859452761179, 14333.283335833206, 14474.710505789877, 14481.058731182493, 14527.491537796166, 14572.271386430675, 14527.491537796179, 14650.706985860277, 14666.04670696404, 14719.337629806658, 14734.63163420915, 745.7017193122767, 899.95050272235, 914.085914085914, 917.334932174175, 919.0350132361027, 885.8184072265202, 893.7988952485704, 897.2821742605922, 897.6992707443014, 898.2230370729304, 937.6483818568037, 941.9105185007413, 944.8299306124894, 945.1965829045291, 949.8480243161096, 780.9531428114332, 923.4966943016005, 939.0937745075967, 940.3323640215456, 946.6875930942807, 686.5949090036852, 686.7699320727562, 686.8454597715524, 692.2869444472202, 697.0972590495321, 14139.434422623082, 14184.219867907364, 14186.858131418658, 14188.574342769733, 14191.574252772434, 13425.127366721132, 13707.931460342734, 13747.243901585409, 13842.031057825956, 13869.0, 11638.70903227426, 11767.41162941858, 12037.819432708517, 12066.638000859988, 12097.818532722016, 4005.7796821174825, 4015.7992100395154, 4055.7160998729805, 4059.188162367538, 4098.016476045727, 60696.393036069516, 60874.391256087314, 60922.69538652323, 61108.0, 61666.69166654183, 11244.381559014333, 11445.427728613537, 11458.656240312805, 11577.363245021435, 11949.64151075469, 20404.693929591067, 20464.488387790127, 20564.38306850797, 20569.0, 20617.89691051565, 8768.473891566526, 8955.149260820212, 8961.462312261285, 8969.50667713282, 9090.818183636422, 5085.542301192911, 5140.228965655182, 5212.921806172911, 5230.08473517133, 5282.339707536558, 3502.7372947029075, 3560.626134255918, 3573.3746594346408, 3590.9461358079648, 3599.3341231872187, 633.5786701843315, 689.7516893918186, 700.2682197104039, 700.8282970672116, 701.5124488480457, 713.2439614009063, 827.7392621324263, 831.7005877883956, 854.4189950833493, 855.5722138930535, 9290.628374865066, 9406.38858474197, 9925.65260215889, 9941.80116397668, 10093.899061009442, 726.498715886037, 764.6444403352357, 793.5794029164553, 805.4643661964728, 829.1998221716073, 4469.687121901436, 4746.833860814855, 4780.880477988008, 4782.736949467743, 4821.710697358169, 57008.0, 58703.41296587065, 58871.41128588745, 58984.41015589875, 65838.67080664566, 55418.0, 55759.0, 56622.71688641531, 58305.416945830846, 58332.41667583355, 51891.22163167556, 51923.48076519262, 52500.21249681334, 52614.21078683823, 53099.46900530945, 9890.45602491841, 10006.649767258112, 10010.899891000996, 10086.949565252127, 10147.0, 37565.812170940066, 38613.22773544457, 39526.0, 40090.599094008685, 40186.0, 46540.0, 47246.76376618095, 50607.0, 51291.2306315413, 52392.0, 11842.11184161174, 12162.635120946386, 13006.154599950973, 13155.276459794803, 13297.468101275841, 13087.869121309046, 13444.126131801402, 13572.93213533926, 13582.59252222435, 13909.582712518235, 13028.348582570645, 13603.251821149932, 13784.104033237807, 13876.72246555043, 14058.718825623635, 12784.87215127874, 13175.60473185806, 13303.66740831487, 13400.865991339962, 14353.712925741636, 13076.084674072723, 13325.933370333087, 13650.317484125953, 14107.365168567645, 14116.647083822576, 11039.172062095215, 11307.151963602928, 11497.0, 11608.535658573901, 12000.459979301128, 10180.236482263712, 10905.400202988912, 10907.672769816918, 10958.616448424267, 10988.945055274673], "value": 7207.495865485752, "unit": "score"}], "name": "dromaeo_css", "value": 7472.667075141334, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 104.0, 109.0, 109.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 164.0, 185.0, 133.0, 163.0, 159.0, 128.0, 176.0, 125.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 162.0, 160.0, 161.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 166.0, 77.0, 73.0, 78.0, 74.0, 163.0, 75.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 165.0, 91.0, 91.0, 92.0, 146.0, 91.0, 93.0, 141.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 54.0, 54.0, 56.0, 74.0, 53.0, 52.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 77.0, 79.0, 74.0, 74.0, 75.0, 77.0, 73.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 114.0, 115.0, 111.0, 114.0, 111.0, 114.0, 129.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 157.0, 156.0, 165.0, 160.0, 162.0, 159.0, 162.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 65.0, 64.0, 66.0, 67.0, 66.0, 65.0, 72.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1513.6999999999998, "alertThreshold": 2.0}]} 03:24:59 INFO - Return code: 0 03:24:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:24:59 ERROR - # TBPL SUCCESS # 03:24:59 INFO - Running post-action listener: _resource_record_post_action 03:24:59 INFO - Running post-run listener: _resource_record_post_run 03:25:00 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 45056; Write bytes: 221073408; Read time: 72; Write time: 110076 03:25:00 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 667648; Read time: 0; Write time: 48 03:25:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 45056; Write bytes: 220405760; Read time: 72; Write time: 110028 03:25:00 INFO - Running post-run listener: _upload_blobber_files 03:25:00 INFO - Blob upload gear active. 03:25:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:25:00 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:25:00 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:25:00 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:25:01 INFO - (blobuploader) - INFO - Open directory for files ... 03:25:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:25:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:01 INFO - (blobuploader) - INFO - Done attempting. 03:25:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:25:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:25:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:02 INFO - (blobuploader) - INFO - Done attempting. 03:25:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:25:02 INFO - Return code: 0 03:25:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:25:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:25:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45f958b8507d7519c84fe27a3e2b6df7012975ae2859918deb8329ed79a390e6799084a534b8027fb6b792eb068b9e99cf9aa575df11cbb511d03d69820cf33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d61bc9f75e6a8c83f79e53ce8f45c8f989b7a8df6fdaf1f879ecf627ec51325f3ae6336dc3e5aff160553c66b95ab4a2df17f8cd122a8afce448e34173004d66"} 03:25:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:25:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:25:02 INFO - Contents: 03:25:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45f958b8507d7519c84fe27a3e2b6df7012975ae2859918deb8329ed79a390e6799084a534b8027fb6b792eb068b9e99cf9aa575df11cbb511d03d69820cf33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d61bc9f75e6a8c83f79e53ce8f45c8f989b7a8df6fdaf1f879ecf627ec51325f3ae6336dc3e5aff160553c66b95ab4a2df17f8cd122a8afce448e34173004d66"} 03:25:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:25:02 INFO - Copying logs to upload dir... 03:25:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:25:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.171124 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-21 03:25:02.668431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 03:25:02.672030) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567 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-Beta/sha512/45f958b8507d7519c84fe27a3e2b6df7012975ae2859918deb8329ed79a390e6799084a534b8027fb6b792eb068b9e99cf9aa575df11cbb511d03d69820cf33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d61bc9f75e6a8c83f79e53ce8f45c8f989b7a8df6fdaf1f879ecf627ec51325f3ae6336dc3e5aff160553c66b95ab4a2df17f8cd122a8afce448e34173004d66"} build_url:https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/TD3Vbf6ITSeQMhlxBrrjIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45f958b8507d7519c84fe27a3e2b6df7012975ae2859918deb8329ed79a390e6799084a534b8027fb6b792eb068b9e99cf9aa575df11cbb511d03d69820cf33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d61bc9f75e6a8c83f79e53ce8f45c8f989b7a8df6fdaf1f879ecf627ec51325f3ae6336dc3e5aff160553c66b95ab4a2df17f8cd122a8afce448e34173004d66"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 03:25:02.697761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:25:02.698085) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466503290.841957-1304569567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:25:02.781412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 03:25:02.781788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 03:25:02.782165) ========= ========= Total master_lag: 0.17 =========