builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1461407475.77 results: success (0) buildid: 20160423004022 builduid: 973597a5c0584e62a5fcd9a4f60287b0 revision: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.774160) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.774635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.774967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.807861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.808149) ========= 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=7de08804244eb36560b44971000001c3-1461407314.100011-1997916193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 03:31:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.4M=0s 2016-04-23 03:31:15 (25.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115614 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.945222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.945537) ========= 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=7de08804244eb36560b44971000001c3-1461407314.100011-1997916193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013726 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.995509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:15.995886) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 --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=7de08804244eb36560b44971000001c3-1461407314.100011-1997916193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 03:31:16,030 truncating revision to first 12 chars 2016-04-23 03:31:16,030 Setting DEBUG logging. 2016-04-23 03:31:16,030 attempt 1/10 2016-04-23 03:31:16,030 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e7d31a29b4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 03:31:16,303 unpacking tar archive at: mozilla-aurora-7e7d31a29b4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:16.613578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:16.614193) ========= script_repo_revision: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:16.614637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:16.614972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:31:16.625789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-23 03:31:16.626512) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1461407314.100011-1997916193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:16 INFO - MultiFileLogger online at 20160423 03:31:16 in /builds/slave/test 03:31:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:31:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:16 INFO - {'append_to_log': False, 03:31:16 INFO - 'base_work_dir': '/builds/slave/test', 03:31:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:16 INFO - 'branch': 'Mozilla-Aurora', 03:31:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:16 INFO - 'config_files': ('talos/linux_config.py',), 03:31:16 INFO - 'default_actions': ('clobber', 03:31:16 INFO - 'read-buildbot-config', 03:31:16 INFO - 'download-and-extract', 03:31:16 INFO - 'populate-webroot', 03:31:16 INFO - 'create-virtualenv', 03:31:16 INFO - 'install', 03:31:16 INFO - 'run-tests'), 03:31:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:16 INFO - 'download_minidump_stackwalk': True, 03:31:16 INFO - 'download_symbols': 'ondemand', 03:31:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:16 INFO - 'installer_path': 'installer.exe', 03:31:16 INFO - 'log_level': 'info', 03:31:16 INFO - 'log_name': 'talos', 03:31:16 INFO - 'log_to_console': True, 03:31:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:16 INFO - 'opt_config_files': (), 03:31:16 INFO - 'pip_index': False, 03:31:16 INFO - 'sps_profile': False, 03:31:16 INFO - 'sps_profile_interval': 0, 03:31:16 INFO - 'suite': 'dromaeojs', 03:31:16 INFO - 'system_bits': '32', 03:31:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:16 INFO - 'title': 'talos-linux64-ix-003', 03:31:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:16 INFO - 'use_talos_json': True, 03:31:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:16 INFO - 'work_dir': 'build'} 03:31:16 INFO - ##### 03:31:16 INFO - ##### Running clobber step. 03:31:16 INFO - ##### 03:31:16 INFO - Running pre-action listener: _resource_record_pre_action 03:31:16 INFO - Running main action method: clobber 03:31:16 INFO - rmtree: /builds/slave/test/build 03:31:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:17 INFO - Running post-action listener: _resource_record_post_action 03:31:17 INFO - ##### 03:31:17 INFO - ##### Running read-buildbot-config step. 03:31:17 INFO - ##### 03:31:17 INFO - Running pre-action listener: _resource_record_pre_action 03:31:17 INFO - Running main action method: read_buildbot_config 03:31:17 INFO - Using buildbot properties: 03:31:17 INFO - { 03:31:17 INFO - "project": "", 03:31:17 INFO - "product": "firefox", 03:31:17 INFO - "script_repo_revision": "production", 03:31:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:31:17 INFO - "repository": "", 03:31:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:31:17 INFO - "buildid": "20160423004022", 03:31:17 INFO - "stage_platform": "linux64-pgo", 03:31:17 INFO - "basedir": "/builds/slave/test", 03:31:17 INFO - "nightly_build": "True", 03:31:17 INFO - "buildnumber": 458, 03:31:17 INFO - "slavename": "talos-linux64-ix-003", 03:31:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:31:17 INFO - "platform": "ubuntu64_hw", 03:31:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:17 INFO - "branch": "mozilla-aurora", 03:31:17 INFO - "repo_path": "releases/mozilla-aurora", 03:31:17 INFO - "revision": "7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46", 03:31:17 INFO - "pgo_build": "True", 03:31:17 INFO - "builduid": "973597a5c0584e62a5fcd9a4f60287b0", 03:31:17 INFO - "slavebuilddir": "test" 03:31:17 INFO - } 03:31:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:31:17 INFO - Running post-action listener: _resource_record_post_action 03:31:17 INFO - ##### 03:31:17 INFO - ##### Running download-and-extract step. 03:31:17 INFO - ##### 03:31:17 INFO - Running pre-action listener: _resource_record_pre_action 03:31:17 INFO - Running main action method: download_and_extract 03:31:17 INFO - mkdir: /builds/slave/test/build/tests 03:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:17 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:31:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:31:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:18 INFO - Downloaded 1448 bytes. 03:31:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:31:18 INFO - Using the following test package requirements: 03:31:18 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:18 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:18 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:18 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'jsshell-linux-x86_64.zip'], 03:31:18 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:18 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:18 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:18 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:18 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:18 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:18 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:18 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:19 INFO - Downloaded 23358998 bytes. 03:31:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:21 INFO - Return code: 0 03:31:21 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:21 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:23 INFO - Downloaded 23358998 bytes. 03:31:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:24 INFO - Return code: 0 03:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:24 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:25 INFO - Downloaded 10845194 bytes. 03:31:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:31:26 INFO - Return code: 0 03:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:26 INFO - https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:27 INFO - Downloaded 60835987 bytes. 03:31:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:27 INFO - mkdir: /builds/slave/test/properties 03:31:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:27 INFO - Contents: 03:31:27 INFO - build_url:https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:31:28 INFO - Running post-action listener: _resource_record_post_action 03:31:28 INFO - Running post-action listener: set_extra_try_arguments 03:31:28 INFO - ##### 03:31:28 INFO - ##### Running populate-webroot step. 03:31:28 INFO - ##### 03:31:28 INFO - Running pre-action listener: _resource_record_pre_action 03:31:28 INFO - Running main action method: populate_webroot 03:31:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:28 INFO - '--tppagecycles', 03:31:28 INFO - '7'], 03:31:28 INFO - 'tests': ['tsvgm']}}, 03:31:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:31:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:31:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'tests': ['damp', 'tps']}, 03:31:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['damp', 'tps']}, 03:31:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:31:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:28 INFO - 'other': {'tests': ['a11yr', 03:31:28 INFO - 'ts_paint', 03:31:28 INFO - 'tpaint', 03:31:28 INFO - 'sessionrestore', 03:31:28 INFO - 'sessionrestore_no_auto_restore', 03:31:28 INFO - 'tabpaint']}, 03:31:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['a11yr', 03:31:28 INFO - 'ts_paint', 03:31:28 INFO - 'tpaint', 03:31:28 INFO - 'sessionrestore', 03:31:28 INFO - 'sessionrestore_no_auto_restore', 03:31:28 INFO - 'tabpaint']}, 03:31:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['a11yr', 03:31:28 INFO - 'ts_paint', 03:31:28 INFO - 'tpaint', 03:31:28 INFO - 'sessionrestore', 03:31:28 INFO - 'sessionrestore_no_auto_restore', 03:31:28 INFO - 'tabpaint']}, 03:31:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['a11yr', 03:31:28 INFO - 'ts_paint', 03:31:28 INFO - 'tpaint', 03:31:28 INFO - 'sessionrestore', 03:31:28 INFO - 'sessionrestore_no_auto_restore', 03:31:28 INFO - 'tabpaint']}, 03:31:28 INFO - 'other_l64': {'tests': ['a11yr', 03:31:28 INFO - 'ts_paint', 03:31:28 INFO - 'tpaint', 03:31:28 INFO - 'sessionrestore', 03:31:28 INFO - 'sessionrestore_no_auto_restore', 03:31:28 INFO - 'tabpaint']}, 03:31:28 INFO - 'other_nol64': {'tests': ['a11yr', 03:31:28 INFO - 'ts_paint', 03:31:28 INFO - 'tpaint', 03:31:28 INFO - 'sessionrestore', 03:31:28 INFO - 'sessionrestore_no_auto_restore', 03:31:28 INFO - 'tabpaint']}, 03:31:28 INFO - 'svgr': {'tests': ['tsvgx', 03:31:28 INFO - 'tsvgr_opacity', 03:31:28 INFO - 'tart', 03:31:28 INFO - 'tscrollx', 03:31:28 INFO - 'cart']}, 03:31:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['tsvgx', 03:31:28 INFO - 'tsvgr_opacity', 03:31:28 INFO - 'tart', 03:31:28 INFO - 'tscrollx', 03:31:28 INFO - 'cart']}, 03:31:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'tests': ['tp5o']}, 03:31:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'talos_options': ['--e10s'], 03:31:28 INFO - 'tests': ['tp5o']}, 03:31:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'talos_options': ['--xperf_path', 03:31:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:28 INFO - 'tests': ['tp5n']}, 03:31:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:28 INFO - 'talos_options': ['--e10s', 03:31:28 INFO - '--xperf_path', 03:31:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:28 INFO - 'tests': ['tp5n']}}, 03:31:28 INFO - 'talos.zip': {'path': '', 03:31:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:28 INFO - Running post-action listener: _resource_record_post_action 03:31:28 INFO - ##### 03:31:28 INFO - ##### Running create-virtualenv step. 03:31:28 INFO - ##### 03:31:28 INFO - Running pre-action listener: _resource_record_pre_action 03:31:28 INFO - Running main action method: create_virtualenv 03:31:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:28 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:31:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:28 INFO - Using real prefix '/usr' 03:31:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:31 INFO - Installing pip.................done. 03:31:31 INFO - Return code: 0 03:31:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31: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:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:31:31 INFO - Using env: {'DISPLAY': ':0', 03:31:31 INFO - 'HOME': '/home/cltbld', 03:31:31 INFO - 'LANG': 'en_US.UTF-8', 03:31:31 INFO - 'LANGUAGE': 'en_US:en', 03:31:31 INFO - 'LOGNAME': 'cltbld', 03:31:31 INFO - 'MAIL': '/var/mail/cltbld', 03:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:31 INFO - 'MOZ_NO_REMOTE': '1', 03:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:31 INFO - 'NO_EM_RESTART': '1', 03:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:31 INFO - 'PWD': '/builds/slave/test', 03:31:31 INFO - 'SHELL': '/bin/bash', 03:31:31 INFO - 'SHLVL': '1', 03:31:31 INFO - 'TERM': 'linux', 03:31:31 INFO - 'TMOUT': '86400', 03:31:31 INFO - 'USER': 'cltbld', 03:31:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:31 INFO - '_': '/tools/buildbot/bin/python'} 03:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:31 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:31:31 INFO - Cleaning up... 03:31:31 INFO - Return code: 0 03:31:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:31: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:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:31:31 INFO - Using env: {'DISPLAY': ':0', 03:31:31 INFO - 'HOME': '/home/cltbld', 03:31:31 INFO - 'LANG': 'en_US.UTF-8', 03:31:31 INFO - 'LANGUAGE': 'en_US:en', 03:31:31 INFO - 'LOGNAME': 'cltbld', 03:31:31 INFO - 'MAIL': '/var/mail/cltbld', 03:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:31 INFO - 'MOZ_NO_REMOTE': '1', 03:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:31 INFO - 'NO_EM_RESTART': '1', 03:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:31 INFO - 'PWD': '/builds/slave/test', 03:31:31 INFO - 'SHELL': '/bin/bash', 03:31:31 INFO - 'SHLVL': '1', 03:31:31 INFO - 'TERM': 'linux', 03:31:31 INFO - 'TMOUT': '86400', 03:31:31 INFO - 'USER': 'cltbld', 03:31:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:31 INFO - '_': '/tools/buildbot/bin/python'} 03:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:31 INFO - Downloading/unpacking psutil>=0.7.1 03:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:33 INFO - Installing collected packages: psutil 03:31:33 INFO - Running setup.py install for psutil 03:31:34 INFO - building 'psutil._psutil_linux' extension 03:31:34 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:31:34 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:31:34 INFO - building 'psutil._psutil_posix' extension 03:31:34 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:31:34 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:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:34 INFO - Successfully installed psutil 03:31:34 INFO - Cleaning up... 03:31:34 INFO - Return code: 0 03:31:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:31:34 INFO - Using env: {'DISPLAY': ':0', 03:31:34 INFO - 'HOME': '/home/cltbld', 03:31:34 INFO - 'LANG': 'en_US.UTF-8', 03:31:34 INFO - 'LANGUAGE': 'en_US:en', 03:31:34 INFO - 'LOGNAME': 'cltbld', 03:31:34 INFO - 'MAIL': '/var/mail/cltbld', 03:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:34 INFO - 'MOZ_NO_REMOTE': '1', 03:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:34 INFO - 'NO_EM_RESTART': '1', 03:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:34 INFO - 'PWD': '/builds/slave/test', 03:31:34 INFO - 'SHELL': '/bin/bash', 03:31:34 INFO - 'SHLVL': '1', 03:31:34 INFO - 'TERM': 'linux', 03:31:34 INFO - 'TMOUT': '86400', 03:31:34 INFO - 'USER': 'cltbld', 03:31:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:34 INFO - '_': '/tools/buildbot/bin/python'} 03:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:36 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:31:36 INFO - Installing collected packages: mozsystemmonitor 03:31:36 INFO - Running setup.py install for mozsystemmonitor 03:31:36 INFO - Successfully installed mozsystemmonitor 03:31:36 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:37 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:31:37 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:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:40 INFO - Downloading docopt-0.6.1.tar.gz 03:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:40 INFO - Running setup.py install for blobuploader 03:31:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:40 INFO - Running setup.py install for requests 03:31:41 INFO - Running setup.py install for docopt 03:31:41 INFO - Successfully installed blobuploader requests docopt 03:31:41 INFO - Cleaning up... 03:31:41 INFO - Return code: 0 03:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:41 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:31:41 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:31:41 INFO - Using env: {'DISPLAY': ':0', 03:31:41 INFO - 'HOME': '/home/cltbld', 03:31:41 INFO - 'LANG': 'en_US.UTF-8', 03:31:41 INFO - 'LANGUAGE': 'en_US:en', 03:31:41 INFO - 'LOGNAME': 'cltbld', 03:31:41 INFO - 'MAIL': '/var/mail/cltbld', 03:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:41 INFO - 'MOZ_NO_REMOTE': '1', 03:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:41 INFO - 'NO_EM_RESTART': '1', 03:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:41 INFO - 'PWD': '/builds/slave/test', 03:31:41 INFO - 'SHELL': '/bin/bash', 03:31:41 INFO - 'SHLVL': '1', 03:31:41 INFO - 'TERM': 'linux', 03:31:41 INFO - 'TMOUT': '86400', 03:31:41 INFO - 'USER': 'cltbld', 03:31:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:41 INFO - '_': '/tools/buildbot/bin/python'} 03:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:41 INFO - Running setup.py (path:/tmp/pip-bMWrbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:41 INFO - Running setup.py (path:/tmp/pip-9XYgNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:41 INFO - Running setup.py (path:/tmp/pip-ws4PxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:41 INFO - Running setup.py (path:/tmp/pip-KaDe1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:41 INFO - Running setup.py (path:/tmp/pip-WrFzaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:41 INFO - Running setup.py (path:/tmp/pip-sNTHJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:41 INFO - Running setup.py (path:/tmp/pip-GoGPHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:41 INFO - Running setup.py (path:/tmp/pip-MvYafW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:41 INFO - Running setup.py (path:/tmp/pip-LJLJg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:42 INFO - Running setup.py (path:/tmp/pip-HaaBHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:42 INFO - Running setup.py (path:/tmp/pip-KmfQ_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:42 INFO - Running setup.py (path:/tmp/pip-EGMuJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:42 INFO - Running setup.py (path:/tmp/pip-IjpZQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:42 INFO - Running setup.py (path:/tmp/pip-AJii4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:42 INFO - Running setup.py (path:/tmp/pip-eC0iyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:42 INFO - Running setup.py (path:/tmp/pip-PnfkX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:42 INFO - Running setup.py (path:/tmp/pip-TwhUix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:42 INFO - Running setup.py install for manifestparser 03:31:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:42 INFO - Running setup.py install for mozcrash 03:31:42 INFO - Running setup.py install for mozdebug 03:31:42 INFO - Running setup.py install for mozdevice 03:31:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozfile 03:31:43 INFO - Running setup.py install for mozhttpd 03:31:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozinfo 03:31:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozInstall 03:31:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozleak 03:31:43 INFO - Running setup.py install for mozlog 03:31:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for moznetwork 03:31:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozprocess 03:31:43 INFO - Running setup.py install for mozprofile 03:31:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:43 INFO - Running setup.py install for mozrunner 03:31:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Running setup.py install for mozscreenshot 03:31:44 INFO - Running setup.py install for moztest 03:31:44 INFO - Running setup.py install for mozversion 03:31:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:44 INFO - Cleaning up... 03:31:44 INFO - Return code: 0 03:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31: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:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:44 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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:44 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:31:44 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:31:44 INFO - Using env: {'DISPLAY': ':0', 03:31:44 INFO - 'HOME': '/home/cltbld', 03:31:44 INFO - 'LANG': 'en_US.UTF-8', 03:31:44 INFO - 'LANGUAGE': 'en_US:en', 03:31:44 INFO - 'LOGNAME': 'cltbld', 03:31:44 INFO - 'MAIL': '/var/mail/cltbld', 03:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:44 INFO - 'MOZ_NO_REMOTE': '1', 03:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:44 INFO - 'NO_EM_RESTART': '1', 03:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:44 INFO - 'PWD': '/builds/slave/test', 03:31:44 INFO - 'SHELL': '/bin/bash', 03:31:44 INFO - 'SHLVL': '1', 03:31:44 INFO - 'TERM': 'linux', 03:31:44 INFO - 'TMOUT': '86400', 03:31:44 INFO - 'USER': 'cltbld', 03:31:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:44 INFO - '_': '/tools/buildbot/bin/python'} 03:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:44 INFO - Running setup.py (path:/tmp/pip-ZqtYCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:44 INFO - Running setup.py (path:/tmp/pip-Es3ARr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:44 INFO - Running setup.py (path:/tmp/pip-7VWfXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:44 INFO - Running setup.py (path:/tmp/pip-fhyoO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:44 INFO - Running setup.py (path:/tmp/pip-ZNAc3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:44 INFO - Running setup.py (path:/tmp/pip-vPhBR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:45 INFO - Running setup.py (path:/tmp/pip-I6exmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:45 INFO - Running setup.py (path:/tmp/pip-lWUpN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:45 INFO - Running setup.py (path:/tmp/pip-7lmH4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:45 INFO - Running setup.py (path:/tmp/pip-VrMuMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:45 INFO - Running setup.py (path:/tmp/pip-FwMruE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:45 INFO - Running setup.py (path:/tmp/pip-as4WGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:45 INFO - Running setup.py (path:/tmp/pip-qGzgdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:45 INFO - Running setup.py (path:/tmp/pip-GDsCK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:45 INFO - Running setup.py (path:/tmp/pip-_y1tF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:45 INFO - Running setup.py (path:/tmp/pip-4dmTi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:45 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:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:45 INFO - Running setup.py (path:/tmp/pip-wSh9nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:45 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:31:45 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:31:45 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:31:45 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:31:45 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:31:45 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:31:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - Downloading blessings-1.6.tar.gz 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:47 INFO - Installing collected packages: blessings 03:31:47 INFO - Running setup.py install for blessings 03:31:47 INFO - Successfully installed blessings 03:31:47 INFO - Cleaning up... 03:31:47 INFO - Return code: 0 03:31:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:48 INFO - Reading from file tmpfile_stdout 03:31:48 INFO - Current package versions: 03:31:48 INFO - argparse == 1.2.1 03:31:48 INFO - blessings == 1.6 03:31:48 INFO - blobuploader == 1.2.4 03:31:48 INFO - docopt == 0.6.1 03:31:48 INFO - manifestparser == 1.1 03:31:48 INFO - mozInstall == 1.12 03:31:48 INFO - mozcrash == 0.17 03:31:48 INFO - mozdebug == 0.1 03:31:48 INFO - mozdevice == 0.48 03:31:48 INFO - mozfile == 1.2 03:31:48 INFO - mozhttpd == 0.7 03:31:48 INFO - mozinfo == 0.9 03:31:48 INFO - mozleak == 0.1 03:31:48 INFO - mozlog == 3.1 03:31:48 INFO - moznetwork == 0.27 03:31:48 INFO - mozprocess == 0.22 03:31:48 INFO - mozprofile == 0.28 03:31:48 INFO - mozrunner == 6.11 03:31:48 INFO - mozscreenshot == 0.1 03:31:48 INFO - mozsystemmonitor == 0.0 03:31:48 INFO - moztest == 0.7 03:31:48 INFO - mozversion == 1.4 03:31:48 INFO - psutil == 3.1.1 03:31:48 INFO - requests == 1.2.3 03:31:48 INFO - wsgiref == 0.1.2 03:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:48 INFO - Using env: {'DISPLAY': ':0', 03:31:48 INFO - 'HOME': '/home/cltbld', 03:31:48 INFO - 'LANG': 'en_US.UTF-8', 03:31:48 INFO - 'LANGUAGE': 'en_US:en', 03:31:48 INFO - 'LOGNAME': 'cltbld', 03:31:48 INFO - 'MAIL': '/var/mail/cltbld', 03:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:48 INFO - 'MOZ_NO_REMOTE': '1', 03:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:48 INFO - 'NO_EM_RESTART': '1', 03:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:48 INFO - 'PWD': '/builds/slave/test', 03:31:48 INFO - 'SHELL': '/bin/bash', 03:31:48 INFO - 'SHLVL': '1', 03:31:48 INFO - 'TERM': 'linux', 03:31:48 INFO - 'TMOUT': '86400', 03:31:48 INFO - 'USER': 'cltbld', 03:31:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:48 INFO - '_': '/tools/buildbot/bin/python'} 03:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:31:48 INFO - Cleaning up... 03:31:48 INFO - Return code: 0 03:31:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:31:48 INFO - Using env: {'DISPLAY': ':0', 03:31:48 INFO - 'HOME': '/home/cltbld', 03:31:48 INFO - 'LANG': 'en_US.UTF-8', 03:31:48 INFO - 'LANGUAGE': 'en_US:en', 03:31:48 INFO - 'LOGNAME': 'cltbld', 03:31:48 INFO - 'MAIL': '/var/mail/cltbld', 03:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:48 INFO - 'MOZ_NO_REMOTE': '1', 03:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:48 INFO - 'NO_EM_RESTART': '1', 03:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:48 INFO - 'PWD': '/builds/slave/test', 03:31:48 INFO - 'SHELL': '/bin/bash', 03:31:48 INFO - 'SHLVL': '1', 03:31:48 INFO - 'TERM': 'linux', 03:31:48 INFO - 'TMOUT': '86400', 03:31:48 INFO - 'USER': 'cltbld', 03:31:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:48 INFO - '_': '/tools/buildbot/bin/python'} 03:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:48 INFO - Downloading/unpacking jsonschema 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:50 INFO - Downloading/unpacking functools32 (from jsonschema) 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:50 INFO - warning: no files found matching '*.txt' 03:31:50 INFO - no previously-included directories found matching 'build' 03:31:50 INFO - no previously-included directories found matching 'dist' 03:31:50 INFO - no previously-included directories found matching '.git*' 03:31:50 INFO - Installing collected packages: jsonschema, functools32 03:31:50 INFO - Running setup.py install for functools32 03:31:50 INFO - warning: no files found matching '*.txt' 03:31:50 INFO - no previously-included directories found matching 'build' 03:31:50 INFO - no previously-included directories found matching 'dist' 03:31:50 INFO - no previously-included directories found matching '.git*' 03:31:50 INFO - Successfully installed jsonschema functools32 03:31:50 INFO - Cleaning up... 03:31:50 INFO - Return code: 0 03:31:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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 0x7f657a61ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, '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': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:31:50 INFO - Using env: {'DISPLAY': ':0', 03:31:50 INFO - 'HOME': '/home/cltbld', 03:31:50 INFO - 'LANG': 'en_US.UTF-8', 03:31:50 INFO - 'LANGUAGE': 'en_US:en', 03:31:50 INFO - 'LOGNAME': 'cltbld', 03:31:50 INFO - 'MAIL': '/var/mail/cltbld', 03:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:50 INFO - 'MOZ_NO_REMOTE': '1', 03:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:50 INFO - 'NO_EM_RESTART': '1', 03:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:50 INFO - 'PWD': '/builds/slave/test', 03:31:50 INFO - 'SHELL': '/bin/bash', 03:31:50 INFO - 'SHLVL': '1', 03:31:50 INFO - 'TERM': 'linux', 03:31:50 INFO - 'TMOUT': '86400', 03:31:50 INFO - 'USER': 'cltbld', 03:31:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:50 INFO - '_': '/tools/buildbot/bin/python'} 03:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:51 INFO - Downloading/unpacking flake8 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:53 INFO - no previously-included directories found matching 'docs/_build' 03:31:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:53 INFO - Running setup.py install for pep8 03:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:53 INFO - no previously-included directories found matching 'docs/_build' 03:31:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:53 INFO - Cleaning up... 03:31:54 INFO - Return code: 0 03:31:54 INFO - Running post-action listener: _resource_record_post_action 03:31:54 INFO - Running post-action listener: _start_resource_monitoring 03:31:54 INFO - Starting resource monitoring. 03:31:54 INFO - ##### 03:31:54 INFO - ##### Running install step. 03:31:54 INFO - ##### 03:31:54 INFO - Running pre-action listener: _resource_record_pre_action 03:31:54 INFO - Running main action method: install 03:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:54 INFO - Reading from file tmpfile_stdout 03:31:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:54 INFO - Reading from file tmpfile_stdout 03:31:54 INFO - Output received: 03:31:54 INFO - Usage: mozinstall [options] installer 03:31:54 INFO - Options: 03:31:54 INFO - -h, --help show this help message and exit 03:31:54 INFO - -d DEST, --destination=DEST 03:31:54 INFO - Directory to install application into. [default: 03:31:54 INFO - "/builds/slave/test"] 03:31:54 INFO - --app=APP Application being installed. [default: firefox] 03:31:54 INFO - mkdir: /builds/slave/test/build/application 03:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:32:09 INFO - Reading from file tmpfile_stdout 03:32:09 INFO - Output received: 03:32:09 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:09 INFO - Running post-action listener: _resource_record_post_action 03:32:09 INFO - ##### 03:32:09 INFO - ##### Running run-tests step. 03:32:09 INFO - ##### 03:32:09 INFO - Running pre-action listener: _resource_record_pre_action 03:32:09 INFO - Running main action method: run_tests 03:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:09 INFO - Python 2.7.3 03:32:09 INFO - Return code: 0 03:32:09 INFO - grabbing minidump binary from tooltool 03:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:09 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 0x13f0160>, '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 0x13f1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f14f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:09 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:32:09 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:32:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:09 INFO - Return code: 0 03:32:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:10 INFO - Return code: 0 03:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:32:10 INFO - Using env: {'DISPLAY': ':0', 03:32:10 INFO - 'HOME': '/home/cltbld', 03:32:10 INFO - 'LANG': 'en_US.UTF-8', 03:32:10 INFO - 'LANGUAGE': 'en_US:en', 03:32:10 INFO - 'LOGNAME': 'cltbld', 03:32:10 INFO - 'MAIL': '/var/mail/cltbld', 03:32:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:10 INFO - 'MOZ_NO_REMOTE': '1', 03:32:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:10 INFO - 'NO_EM_RESTART': '1', 03:32:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:10 INFO - 'PWD': '/builds/slave/test', 03:32:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:10 INFO - 'SHELL': '/bin/bash', 03:32:10 INFO - 'SHLVL': '1', 03:32:10 INFO - 'TERM': 'linux', 03:32:10 INFO - 'TMOUT': '86400', 03:32:10 INFO - 'USER': 'cltbld', 03:32:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461407314.100011-1997916193', 03:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:10 INFO - '_': '/tools/buildbot/bin/python'} 03:32:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:32:10 INFO - mozversion application_buildid: 20160423004022 03:32:10 INFO - mozversion application_changeset: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 03:32:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:10 INFO - mozversion application_name: Firefox 03:32:10 INFO - mozversion application_remotingname: firefox-dev 03:32:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:10 INFO - mozversion application_vendor: Mozilla 03:32:10 INFO - mozversion application_version: 47.0a2 03:32:10 INFO - mozversion platform_buildid: 20160423004022 03:32:10 INFO - mozversion platform_changeset: 7e7d31a29b4ca8cc0e7d08d5403b925bd0117a46 03:32:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:10 INFO - mozversion platform_version: 47.0a2 03:32:10 INFO - using testdate: 1461407530 03:32:10 INFO - actual date: 1461407530 03:32:10 INFO - starting webserver on 'localhost:36935' 03:32:10 INFO - SUITE-START | Running 2 tests 03:32:10 INFO - TEST-START | dromaeo_css 03:32:10 INFO - operating with platform_type : linux_ 03:32:10 INFO - Initialising browser for dromaeo_css test... 03:32:10 INFO - TEST-INFO | started process 6495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX4OOWY/profile http://localhost:36935/getInfo.html) 03:32:15 INFO - PROCESS | 6495 | __metrics Screen width/height:1600/1200 03:32:15 INFO - PROCESS | 6495 | colorDepth:24 03:32:15 INFO - PROCESS | 6495 | Browser inner width/height: 1024/697 03:32:15 INFO - PROCESS | 6495 | __metrics 03:32:16 INFO - PROCESS | 6495 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:32:17 INFO - TEST-INFO | 6495: exit 0 03:32:17 INFO - Browser initialized. 03:32:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:17 INFO - TEST-INFO | started process 6585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX4OOWY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:29 INFO - PROCESS | 6585 | RSS: Main: 142221312 03:32:29 INFO - PROCESS | 6585 | 03:33:20 INFO - PROCESS | 6585 | 1461407600565 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:35:28 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:36935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36935/tests/dromaeo/cssquery-ext.html) 03:35:29 INFO - PROCESS | 6585 | RSS: Main: 255143936 03:35:29 INFO - PROCESS | 6585 | 03:38:31 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:36935/tests/dromaeo/cssquery-ext.html (next: http://localhost:36935/tests/dromaeo/cssquery-jquery.html) 03:38:32 INFO - PROCESS | 6585 | RSS: Main: 224034816 03:38:32 INFO - PROCESS | 6585 | 03:41:34 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:36935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36935/tests/dromaeo/cssquery-mootools.html) 03:41:34 INFO - PROCESS | 6585 | RSS: Main: 223027200 03:41:34 INFO - PROCESS | 6585 | 03:44:36 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:36935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36935/tests/dromaeo/cssquery-prototype.html) 03:44:37 INFO - PROCESS | 6585 | RSS: Main: 211087360 03:44:37 INFO - PROCESS | 6585 | 03:47:39 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:36935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36935/tests/dromaeo/cssquery-yui.html) 03:47:40 INFO - PROCESS | 6585 | RSS: Main: 209809408 03:47:40 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:36935/tests/dromaeo/cssquery-yui.html (next: http://localhost:36935/tests/dromaeo/cssquery-dojo.html) 03:50:42 INFO - PROCESS | 6585 | RSS: Main: 256634880 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | __start_tp_report 03:50:42 INFO - PROCESS | 6585 | _x_x_mozilla_page_load 03:50:42 INFO - PROCESS | 6585 | _x_x_mozilla_page_load_details 03:50:42 INFO - PROCESS | 6585 | |i|pagename|runs| 03:50:42 INFO - PROCESS | 6585 | |0;dojo.html;3263.7225835803956;3346.0129261867746;3361.1765117546206;3364.5626068611077;3393.881214157504;5401.486858748418;5403.297571315728;5409.080456322425;5454.045542030144;5473.31583552056;5411.621186516945;5434.184872269162;5443.891122177554;5445.210444485557;5454.672719636825;4799.664023518355;4885.877853053676;4928.162212423878;4987.75061246938;4996.575291100261;4884.096442158212;4933.383327084114;4958.404991401037;4979.502049795028;5014.147594908874;4984.152694042022;4988.725620090893;5004.224345226496;5005.874853128683;5023.372078490189;4831.661783675144;4937;4962.702237865739;4994.001199760044;5008.974955125219;4866.610671146335;4931.753412329369;4938.9012219755405;4939.382577177853;4960.90078198434;5226.503482169188;5238.371395432534;5250.133727934886;5266.710330931797;5306;5654.151877218409;5775.451332123442;5777.335606405275;5777.5666824987875;5789.334226563915;5850.239468869062;5851.093080572518;5852.385499522531;5871.148683440877;5900.763969441217;5461.699606521679;5470.890582188374;5481.862953426196;5482.122860342366;5484.287042684466;5812.709364531841;5926.1999630049395;5943.702814859326;5960.314563825129;6021;5766.798162064308;5785.623934444247;5802.564807639359;5803.042497987784;5805.274340707411;5823.592348535646;5837.503812175928;5838.095095260242;5876.882462350729;5880.117982302689;5630.408807075198;5766;5787.2187254720075;5849.356570777211;5854.882902341929;5762.538996880239;5776.364599894008;5797.391273916178;5802.47777700009;5804.245448091806;4325.113351762881;4371.803268852909;4377.5403582624;4379.299312110047;4398.186335527937;3891.8248678809523;3918.275119102918;3959.7030222732833;3973.920521589552;3988.6210809973004;5513.2005859151;5517.61376703635;5545.223668686387;5555.3611334697025;5563.36021357541;5739.7704091836695;5870.677112758839;5902.970485147547;5903.439173278532;5907.084401917709;5479.698616576047;5527.53015993645;5547.362053363834;5562.721863906789;5569.777208911679;5012.824551140766;5025.396952365666;5043.949560504421;5050.974745126251;5071;5812.622179558315;5960.284765828128;6046.939530604725;6065.150878876961;6066.666333351708;5849.239598852122;5858.443447872445;5861.325947515919;5878.882422351615;5886.23478947734;6017.247844019497;6022.608530445507;6032.60788048793;6036.366181550874;6038.184845045863;5587.441255874543;5693.089105743227;5719.142128680564;5759;5783.508401785895;5813.854653633693;5828.504577110993;5837.066069428871;5844.386339434468;5855.063189889597;5684.232628595252;5702.401247868914;5710.172025056427;5711.8000869969355;5716.171155182392;5610.495055444866;5702.258706368311;5712.714364281853;5757.193992840922;5772.451617096369;5580.386157522588;5616.550675945833;5625.409332020243;5628.549716022791;5642.069058605284;5715.399883012224;5744.626599271034;5753.338366087954;5756.769729210785;5757.424257574209;5415.106507426231;5451.454854514517;5598.188262701804;5603.551715862803;5613.550915926634 03:50:42 INFO - PROCESS | 6585 | |1;ext.html;561.2255087978589;569.5529009727362;579.9826005219845;585.023011570677;611.4710775179472;39225;39935.400968985414;40004.399934000976;40098.99999999996;40102.59897401025;43033.35449968245;43676.781616091874;43730.12539749203;43751.56248437515;43805.7809710951;8786.297096232302;8969.237614802749;8971.327150463709;9018.278537717;9022.052684468135;8961.820763584725;9150.816983660323;9179.219766319871;9180.632774689004;9185.311101667368;9173.40372875761;9337;9337.813243735121;9350.532473376337;9352.625894964192;9157.267418606496;9166.679166229216;9210.49342286174;9263.953680231623;9288.535573221312;9074.818503629956;9207.815843683089;9211.447313161232;9238.769030774285;9239.029901860342;41914;42539.57460425418;42584.574154258684;42588.787056064524;42614.57385426137;3731.421629647409;3798.411246256807;3891.6302951219873;4051.007503161715;4238.87283381499;32540.18649533757;32790.83604581986;32993.835030824936;33068.6693133068;33500.162495937555;4151.8962025949595;4190.53904070552;4262.701610887239;4302.612764851178;4368.650507959355;286504;287257;288052.5597372021;288256.5587172051;288283;45086.32370514445;45983.5401645986;60902.69548652229;61646;61695.383046168965;44474.77762611231;44840.55159448364;44870.551294486635;45087.32369014467;45163.548364516595;14560.126392416489;14728.779068313985;14736.705265894621;14737.631559211106;14756.926215368854;11339.829902551468;11380.374079425546;11409.48657310423;11410.543578256942;11418.371989540656;15238.466653667068;15629.921850390676;15772.447964321194;15785.36858525669;15791;5841.88316233673;5958.970205148947;6136.662483563447;6200.0079987202735;6233.96883015582;1011.9747006324901;1049.375621505203;1067.8077945969644;1100.2573263047411;1180.7756526259984;29728.702712972594;29785.40429191404;29838.40323193524;30504.694953050184;30657.846710766302;1152.5101831721486;1168.3574034281282;1174.518447436547;1183.988160118388;1202.2305724336431;15289.515718263177;15909.363625455084;16017.759733604005;16063.357465701474;16164.27260773268;336742;339309;340439;340897;341191;55781;56353.43646563564;56360;56397.15404268939;56447.435525645036;1254.4668515880714;1337.5920344294889;1442.8917831162705;1490.3740429019838;1503.3460444706589;27838.721612784422;27981;28099;28107.437851242452;28448.857755711088;42135.36796947987;42279.788601056796;42446.78776606221;42609.36085958651;42619.360709588764;190897;228618;229044;229814;229859;30372.84813575918;34692.653073469955;34890.65109348874;34907.127321817155;35054.824725876206;41070;41697.79151104225;41770;42811;42862.57137428586;37299.62700372961;37443.25113497769;38102;38275.42586861143;38291.234175316895;37195.25609487849;37819.81090094642;37820;37869.62130378661;38332.425013625376;37633.62366376301;37740.43389349217;38110.23779524338;38630.42054369243;38810.22379552449;33109.83445082759;34282;34299.82850085734;34596.30807383788;34601.307973840885;26068.217953461426;26456;26598.202053938414;26700.30715226029;26716.465670686088 03:50:42 INFO - PROCESS | 6585 | |2;jquery.html;390.8475694479152;393.69685342286436;394.8795617336711;396.2530629762897;406.31941497990874;18624.534386640342;18798.624027519443;18829.811701882976;19459.902700486513;19474.707879381804;13390.397432115555;14243.572692819205;17462.82537174628;18294.451166464994;18566.535836604093;5460.808871689492;5610.579206559504;5636.436356364372;5643.943560564403;5645.520130788888;4259.659227261812;5473.75368108436;5625.80309689161;5665.971670141644;5682.232898558704;4241.639460645849;5614;5636.549076073925;5953.493953013999;6170.167027451282;6127.172831667713;6135.447809697104;6143.170671959273;6160.1683772690785;6168.845778855542;5299.894002119936;5442.265294185274;5489.149181876815;5502.284702988626;5505.119180931072;20628.071736771883;21313.786862131336;21415.14339426421;21431.357059288246;21525;2357.9174728884577;2683.973160268392;2759;2781.401998570317;2814.7326004029787;13680.247586382746;13707.931460342734;13813.585592432242;13895;14119.717605647933;1923.2691577200715;1981.3758666020158;1988.2444671024919;1993.800619938009;2035.6946458031266;64337.356626433604;65633.3436665632;65849;66105.3389466104;66349.66825165843;9995.450250236161;10130.44282564466;10284.125849302744;10299.742506437398;10379.63671271517;14670.633234169018;14732.116073035651;14781.33483993223;14787.704245915022;14792.556223313319;7458.664360103809;7519.548827070394;7624.19945905683;7690.577018263937;7705.961470192613;7143.607101609461;7180.102487189101;7210.170830354471;7228.457865660096;7315.231900650461;6106.664133472613;6155.6614386209185;6213.813585592439;6243.906341404791;6330.6201627901555;1941.5340318323783;1959.3534133736118;1968.1756679165157;1981.2174191194686;1990.4924244317606;1094.3379255550437;1096.1614365010773;1120.7254222715324;1157.9305241685527;1184.9052075833913;16362.34550617962;17562.121893905252;17575.20911558983;17752;17768.46694599164;1037.8754549453963;1074.8495210670512;1091.924454412403;1093.8195197792434;1113.9610113646145;10256.38461692301;10448.477576121164;10468.52891619879;10471.214658900613;10519.368837869599;343398;345530;347770;348833;433830;66878;68691.31308686949;70258.2974170262;72218.2778172222;73036.26963730295;1053.4574694032578;1060.211643377911;1076.1390887290136;1077.7682798198268;1089.9237053406187;15643.687126257639;15698.450554230547;15698.607534811721;15871.2064396782;15948.521544353687;33700;34825.47761783525;35017.29965400627;35517.46723799093;35697.82151089228;49133;49168.50831491639;49223.75388123036;49287.50712492829;49964.50035499599;8135.30849877767;8151;8291.95854020726;8294.129116442688;8367.707130250412;11779.469923853276;12602;12962.740745185232;13008.674783130498;13064.54274100402;10498.842517362398;11207.66377008691;11412.258203216765;11432.599859004895;11847.052235821286;10596.205284603531;10708.411037392707;10888.128949684165;11189.440527973406;11585.710357241136;11475.368854712737;11560.537578496765;11574.826377604175;11661.6501504955;11728.061755059403;8367.07962124178;8485.95757021211;8550.1449855014;8605.741827745178;8720.738377848675;9048.9234455707;10991.725206869893;11164.218504704917;11369.772604548029;11695.415229238673 03:50:42 INFO - PROCESS | 6585 | |3;mootools.html;1510.4939845151873;1594.62526306318;1601.6636506333668;1851.7592712947314;1954.9315773947915;7948.364130869524;8141.837163256731;8144.552049637267;8149.225823546753;8153.510789352636;8041.7185398511065;8209.055958564766;8210.137935516774;8211.973503312085;8214.671413143482;2023.8988050597484;2321.0367697405554;2343.5078633486987;2449.4856080223176;2512.170983575416;2471.233917485585;2482.900683972639;2488.6764720586298;2492.8753562321904;2502.699676038878;2449.2529778417575;2482.5531404347303;2486.3908342456034;2488.415222422729;2489.601663733803;2376.5009348036933;2424.4302588891596;2435.8538487690794;2438.0247900839718;2438.7195472520534;2393.1384701507445;2399.1003373734848;2458.9754102459106;2467.247489515697;2468.8888999995042;8319.334453243726;8371.95814020926;8378.622961966727;8379.70671026511;8382.538960357178;5074.213496907948;5200.063988482072;5234.6335756497065;5242.9213561796605;5253.52718255355;3278.655741147169;3351.245969656832;3518.1732292911147;3527.1182204448887;3528.576570811493;1009.6264382178641;1034.92884864166;1035.5391850626474;1054.5412745455674;1115.3530952047875;11688;11698.766024679544;11705.12211584126;11705.941470292679;11714.414279286002;4742.857714268577;4800.402748163903;4826.7827947742435;4842.5157484251995;4864.148773964542;9819.410835349901;9828.459434731158;9834.164096051916;9847.96596357372;9851;4669.7431641260055;5344.652597581145;5382.73086345689;5392.838214853561;5398.379186393615;4328.61042506176;4810.254410566367;4846.854594362175;4888.802243450306;4903.141950158708;3924.9215015699524;3993.0217096810884;4012.057166565855;4041.6160464755803;4042.4542686737504;1332.6734949937133;1338.7924871644911;1346;1356.7964805279287;1358.517726207202;1423.0963338280267;1438.5324769449762;1464.8901332400112;1501.369424841569;1510;7849.686012559548;7898.4865983712025;8040.316573091236;8062.1937806220085;8086.150954149847;1194.235689158939;1220.5972029230334;1244.3388076917236;1246.2086575024925;1273.7325161716144;6236.844078897973;6251.249850018027;6293.811185664437;6326.43062124411;6327.430531252209;9911.207103431709;10220.386776793417;10351.534180961875;10371.222158338154;10391.168706503462;10009.398496240567;10078.244131690153;10133.797324053477;10158.187345012382;10203.38779673222;8018.518888866687;8022.197780221931;8046.637901294456;8075.717349892608;8123.512589244664;7612.961935190288;7637.350825179699;7685.03937007874;7701.268379503938;7750.961245193738;8459.111793261618;8728;9139.497327646777;9186.173244408035;9219.44683319003;8901.33240007015;8980.910190898006;9095.681651142442;9105.635774568944;9168.587413566273;6610.8347291318105;6810.761623343357;7011.719531218694;7269.818254543467;7365.8158546036775;7883.763487095396;7884.960575197088;7901.328387087162;7930.325922296669;7944.086430060617;6949.583025018515;7114.466415018791;7168.53404528704;7248.456365772483;7358.889616655862;6999.160100787938;7017.403520700594;7095.184053833876;7114.50198486101;7166.068411106523;7398.778036658909;7558.319751222416;7606.391488681003;7619.123800762984;7622.085349758065;7030.121234845645;7077.681504332214;7085.326893945067;7090.290970902868;7094.148702155774;7098.148222213367;7103.183133939663;7169.175544812413;7215.819604509929;7221.061262035902 03:50:42 INFO - PROCESS | 6585 | |4;prototype.html;362.55767963085043;364.77201748906924;365.0909236002354;365.77504834526775;369.4513647233857;5978.372270911557;6008.939910600892;6025.457708806207;6036;6044.607100538473;5927.199828023216;5927.940720592804;5939.643621382709;5941.227640406741;5943.465088142067;4494.8202071917085;4545.386372839674;4663.090697314025;4675.789589468465;4707.717536947777;4675;4677.74272415017;4693.8357157499495;4703.623710103184;4703.741294228816;4641.9071618567605;4649.814007439699;4651.3720647712635;4651.930221046687;4670.392848929634;4457.732536047832;4555.589996900295;4643.3731446255;4647.744374059425;4664.393628828265;4117.691173161995;4129.958700412987;4133.834646614132;4137.586241375869;4139.3583994480905;5646.661200327993;5648.237487939116;5650.265465489501;5651.632643878176;5655.660660360391;5431.348238211401;5436.483534064258;5437.8368648940595;5441.374241962146;5442.047641662693;6288.276848162474;6291.245050593958;6292.056191571255;6304.747810087637;6306.527010474187;4316.740995540277;4442;4453.844115455943;4457.710248833815;4582.702124361906;6478.190226221723;6508.8047358579315;6540.37866402691;6541.084248205255;6546.869062618769;4553.54464553542;4554.476235232991;4558.270676691714;4560.293154561048;4562.1560011398;4622.352870598119;4625.676202665781;4628.930566041512;4633.559811817872;4633.7683115844075;5304;5304.443033481506;5307.893842123136;5317.867053323621;5318.680879147263;6106.236720409949;6293.087502312139;6329.620222786648;6329.715162817684;6347.0479428086155;1610.3961014619517;1616.313066946543;1617.5309160343604;1629.576310159367;1634.3380930723076;1037.1961729659574;1067.989320106789;1076.8438576406377;1094.584058057933;1098.7967226063204;6035.1249068885645;6036.275646922398;6041.72812223451;6042.577019608585;6044.486218671462;6458.6770661466735;6564.934350656527;6568.638724870178;6578.243501997332;6588.703508342136;6060.757569697251;6092.238470191226;6093.26880774301;6093.268807743099;6102.877942441126;3488.3720930232803;3488.8081155536183;3519.2609551993855;3520.2431477232517;3525.383057964897;6679.732810687616;6688;6853.862922741617;6856.725730970805;6861.1080559526945;6744.763933262312;6758.493113016543;6766.966165169143;6770.593764374154;6780.38976492118;6832;6832.6925288362145;6834.4874134440115;6838.555493892782;6842.281560436182;6584.50616203777;6615.404613584608;6621.50338724588;6623.801285961429;6626.503012274003;6334.271558770801;6466.676666166579;6483.319251478527;6488.837779055561;6497.25281592604;6732.831679208059;6806.353396427331;6842.657867106725;6852.211995620368;6870.381665649916;4597.747123908217;4620.168369693488;4631.629469642353;4640.211164102043;4643.558861908114;6580.243272023778;6580.638064906476;6587.077809106825;6609.636469994004;6609.900851487328;6197.659128747962;6423;6424.100625912282;6435;6438.549301548846;6355.841103972438;6368.4586810121655;6368.5860419072615;6396.136521569529;6403.167588213689;6268.843278917881;6271.184745983175;6290.654014029273;6296.496280297473;6296.653684047421;6426.132472116205;6433.5496515243485;6451.70967306463;6454.903176452263;6456.2575303838785;6017;6123.326434092157;6219;6308.306086330592;6314.273858506147 03:50:42 INFO - PROCESS | 6585 | |5;yui.html;809.7773112394093;820.6963423533293;871.6077765005749;907.4918045894295;926.0415469988559;12931.935340323296;13267.071305008652;13277.269750163738;13282.7343453131;13289.867101328984;12640.747185056316;12653.873461265384;12667.176633518839;12680.61958141255;12748.235105893653;788.8185717285028;926.7729406295467;926.8609708543722;954.4893481987139;955.9426434413957;939.5584075484511;940.1538615246264;943.8489841625342;946.5882341181574;946.6308139825439;973.8198433289864;975.0493269062642;975.3708857786723;975.7999610079952;975.9316847820655;812.7317985064915;955.8518429643416;983.6360546597733;984.4388698441891;984.7784248544092;729.8321386081178;731.3527528137583;731.6707481633287;731.6780616528711;732.2750477027704;12889.871101289054;12915.67710807228;12936.547220847226;12944;12953.352332383343;13504.324783760772;14029.719405611831;14035.578932632037;14135.434582616683;14281.500147494788;10661.413622250773;10775.83836242457;10959.06847917928;11010.119190464744;11038.779224415546;3840.692744580455;3871.806409679533;3888.7083468739675;3902.570717221103;3918.255531449044;52351.21473177905;52688.20967685488;52755.47244527544;52817.471825282024;53088.203676944875;11049.226554141133;11254.774904501865;11322.660320190407;11441.599544015919;11623.302601843747;20384.082716277804;20413.285535006202;20424.489387765425;20430.69353959692;20433.48916277105;7844;7876.427907161686;7883.881741773878;7952.483088599222;8142.918570814216;4351.586599273064;4398.868033958986;4412.757298348622;4481.865544033684;4491.124230775033;3342.4484959981332;3349.9162520936684;3367.478040903664;3385.9322813544086;3398.6261511233743;519.6076961893746;565.5080080330057;594.147398483178;602.325395556979;619.6065498408543;691.1188235000315;708.8972099045712;772.3589420780851;773.5513402226695;792.8572856885701;8194.262516373556;8262.628181731836;8425.410221284452;8609.397342185986;8914.031198114973;663.0352836622702;667.4726965697045;745.8881167824869;754.4379437319233;771.4098714483424;4273.081287523198;4311.48262208537;4316.028893498938;4366;4507.977460112678;55260.72369638126;57130.42869571251;57714.7114264426;58227.4177258222;58302;50224.74887625612;50822;51263;51291.23063154056;51435.742821285654;45053.32420013702;45332;45358.31962520565;45688.31467528056;46006.53993460022;8372.372072094739;8406.201410866202;8535.10381409943;8773.605187766694;8852.159044890725;34942.30115397627;35914.64085359113;36221.0944726384;36947.44578831266;37061.59099658514;41146;43955;44099;44543;44617.77691111524;11029.46322345849;12867.227966321676;12936.417861196456;13042.282674452996;13539.458421663023;13288.468461261442;13590.93204533971;14379;14482;14545.92727036358;12845.229286242855;13023.283719395524;13024.54414095502;13117.3927170029;13319.600411987656;12257.938710306391;12333.444994975427;12405.255684658949;12439.626811195678;12769.489220431078;11551.71120721955;11691.590794322157;11713.765724685629;11906.76186476283;12111.273323600612;10053.849192262269;10575.576976920836;10664.733381665521;10669.519871605951;11031.17266205054;10014.699559013241;10198.980101989742;10426.947865260625;10659.626913058006;10816.296940698829 03:50:42 INFO - PROCESS | 6585 | __end_tp_report 03:50:42 INFO - PROCESS | 6585 | __start_cc_report 03:50:42 INFO - PROCESS | 6585 | _x_x_mozilla_cycle_collect,895 03:50:42 INFO - PROCESS | 6585 | __end_cc_report 03:50:42 INFO - PROCESS | 6585 | __startTimestamp1461408642541__endTimestamp 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | ------- Summary: start ------- 03:50:42 INFO - PROCESS | 6585 | Number of tests: 6 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | [#0] dojo.html Cycles:165 Average:5409.20 Median:5613.55 stddev:599.39 (10.7%) stddev-sans-first:577.11 03:50:42 INFO - PROCESS | 6585 | Values: 3263.7 3346.0 3361.2 3364.6 3393.9 5401.5 5403.3 5409.1 5454.0 5473.3 5411.6 5434.2 5443.9 5445.2 5454.7 4799.7 4885.9 4928.2 4987.8 4996.6 4884.1 4933.4 4958.4 4979.5 5014.1 4984.2 4988.7 5004.2 5005.9 5023.4 4831.7 4937.0 4962.7 4994.0 5009.0 4866.6 4931.8 4938.9 4939.4 4960.9 5226.5 5238.4 5250.1 5266.7 5306.0 5654.2 5775.5 5777.3 5777.6 5789.3 5850.2 5851.1 5852.4 5871.1 5900.8 5461.7 5470.9 5481.9 5482.1 5484.3 5812.7 5926.2 5943.7 5960.3 6021.0 5766.8 5785.6 5802.6 5803.0 5805.3 5823.6 5837.5 5838.1 5876.9 5880.1 5630.4 5766.0 5787.2 5849.4 5854.9 5762.5 5776.4 5797.4 5802.5 5804.2 4325.1 4371.8 4377.5 4379.3 4398.2 3891.8 3918.3 3959.7 3973.9 3988.6 5513.2 5517.6 5545.2 5555.4 5563.4 5739.8 5870.7 5903.0 5903.4 5907.1 5479.7 5527.5 5547.4 5562.7 5569.8 5012.8 5025.4 5043.9 5051.0 5071.0 5812.6 5960.3 6046.9 6065.2 6066.7 5849.2 5858.4 5861.3 5878.9 5886.2 6017.2 6022.6 6032.6 6036.4 6038.2 5587.4 5693.1 5719.1 5759.0 5783.5 5813.9 5828.5 5837.1 5844.4 5855.1 5684.2 5702.4 5710.2 5711.8 5716.2 5610.5 5702.3 5712.7 5757.2 5772.5 5580.4 5616.6 5625.4 5628.5 5642.1 5715.4 5744.6 5753.3 5756.8 5757.4 5415.1 5451.5 5598.2 5603.6 5613.6 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | [#1] ext.html Cycles:180 Average:45480.70 Median:38106.12 stddev:75054.99 (197.0%) stddev-sans-first:75189.76 03:50:42 INFO - PROCESS | 6585 | Values: 561.2 569.6 580.0 585.0 611.5 39225.0 39935.4 40004.4 40099.0 40102.6 43033.4 43676.8 43730.1 43751.6 43805.8 8786.3 8969.2 8971.3 9018.3 9022.1 8961.8 9150.8 9179.2 9180.6 9185.3 9173.4 9337.0 9337.8 9350.5 9352.6 9157.3 9166.7 9210.5 9264.0 9288.5 9074.8 9207.8 9211.4 9238.8 9239.0 41914.0 42539.6 42584.6 42588.8 42614.6 3731.4 3798.4 3891.6 4051.0 4238.9 32540.2 32790.8 32993.8 33068.7 33500.2 4151.9 4190.5 4262.7 4302.6 4368.7 286504.0 287257.0 288052.6 288256.6 288283.0 45086.3 45983.5 60902.7 61646.0 61695.4 44474.8 44840.6 44870.6 45087.3 45163.5 14560.1 14728.8 14736.7 14737.6 14756.9 11339.8 11380.4 11409.5 11410.5 11418.4 15238.5 15629.9 15772.4 15785.4 15791.0 5841.9 5959.0 6136.7 6200.0 6234.0 1012.0 1049.4 1067.8 1100.3 1180.8 29728.7 29785.4 29838.4 30504.7 30657.8 1152.5 1168.4 1174.5 1184.0 1202.2 15289.5 15909.4 16017.8 16063.4 16164.3 336742.0 339309.0 340439.0 340897.0 341191.0 55781.0 56353.4 56360.0 56397.2 56447.4 1254.5 1337.6 1442.9 1490.4 1503.3 27838.7 27981.0 28099.0 28107.4 28448.9 42135.4 42279.8 42446.8 42609.4 42619.4 190897.0 228618.0 229044.0 229814.0 229859.0 30372.8 34692.7 34890.7 34907.1 35054.8 41070.0 41697.8 41770.0 42811.0 42862.6 37299.6 37443.3 38102.0 38275.4 38291.2 37195.3 37819.8 37820.0 37869.6 38332.4 37633.6 37740.4 38110.2 38630.4 38810.2 33109.8 34282.0 34299.8 34596.3 34601.3 26068.2 26456.0 26598.2 26700.3 26716.5 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | [#2] jquery.html Cycles:180 Average:23799.10 Median:21423.25 stddev:60152.65 (280.8%) stddev-sans-first:60295.72 03:50:42 INFO - PROCESS | 6585 | Values: 390.8 393.7 394.9 396.3 406.3 18624.5 18798.6 18829.8 19459.9 19474.7 13390.4 14243.6 17462.8 18294.5 18566.5 5460.8 5610.6 5636.4 5643.9 5645.5 4259.7 5473.8 5625.8 5666.0 5682.2 4241.6 5614.0 5636.5 5953.5 6170.2 6127.2 6135.4 6143.2 6160.2 6168.8 5299.9 5442.3 5489.1 5502.3 5505.1 20628.1 21313.8 21415.1 21431.4 21525.0 2357.9 2684.0 2759.0 2781.4 2814.7 13680.2 13707.9 13813.6 13895.0 14119.7 1923.3 1981.4 1988.2 1993.8 2035.7 64337.4 65633.3 65849.0 66105.3 66349.7 9995.5 10130.4 10284.1 10299.7 10379.6 14670.6 14732.1 14781.3 14787.7 14792.6 7458.7 7519.5 7624.2 7690.6 7706.0 7143.6 7180.1 7210.2 7228.5 7315.2 6106.7 6155.7 6213.8 6243.9 6330.6 1941.5 1959.4 1968.2 1981.2 1990.5 1094.3 1096.2 1120.7 1157.9 1184.9 16362.3 17562.1 17575.2 17752.0 17768.5 1037.9 1074.8 1091.9 1093.8 1114.0 10256.4 10448.5 10468.5 10471.2 10519.4 343398.0 345530.0 347770.0 348833.0 433830.0 66878.0 68691.3 70258.3 72218.3 73036.3 1053.5 1060.2 1076.1 1077.8 1089.9 15643.7 15698.5 15698.6 15871.2 15948.5 33700.0 34825.5 35017.3 35517.5 35697.8 49133.0 49168.5 49223.8 49287.5 49964.5 8135.3 8151.0 8292.0 8294.1 8367.7 11779.5 12602.0 12962.7 13008.7 13064.5 10498.8 11207.7 11412.3 11432.6 11847.1 10596.2 10708.4 10888.1 11189.4 11585.7 11475.4 11560.5 11574.8 11661.7 11728.1 8367.1 8486.0 8550.1 8605.7 8720.7 9048.9 10991.7 11164.2 11369.8 11695.4 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | [#3] mootools.html Cycles:180 Average:5887.28 Median:5363.69 stddev:3010.76 (56.1%) stddev-sans-first:3001.23 03:50:42 INFO - PROCESS | 6585 | Values: 1510.5 1594.6 1601.7 1851.8 1954.9 7948.4 8141.8 8144.6 8149.2 8153.5 8041.7 8209.1 8210.1 8212.0 8214.7 2023.9 2321.0 2343.5 2449.5 2512.2 2471.2 2482.9 2488.7 2492.9 2502.7 2449.3 2482.6 2486.4 2488.4 2489.6 2376.5 2424.4 2435.9 2438.0 2438.7 2393.1 2399.1 2459.0 2467.2 2468.9 8319.3 8372.0 8378.6 8379.7 8382.5 5074.2 5200.1 5234.6 5242.9 5253.5 3278.7 3351.2 3518.2 3527.1 3528.6 1009.6 1034.9 1035.5 1054.5 1115.4 11688.0 11698.8 11705.1 11705.9 11714.4 4742.9 4800.4 4826.8 4842.5 4864.1 9819.4 9828.5 9834.2 9848.0 9851.0 4669.7 5344.7 5382.7 5392.8 5398.4 4328.6 4810.3 4846.9 4888.8 4903.1 3924.9 3993.0 4012.1 4041.6 4042.5 1332.7 1338.8 1346.0 1356.8 1358.5 1423.1 1438.5 1464.9 1501.4 1510.0 7849.7 7898.5 8040.3 8062.2 8086.2 1194.2 1220.6 1244.3 1246.2 1273.7 6236.8 6251.2 6293.8 6326.4 6327.4 9911.2 10220.4 10351.5 10371.2 10391.2 10009.4 10078.2 10133.8 10158.2 10203.4 8018.5 8022.2 8046.6 8075.7 8123.5 7613.0 7637.4 7685.0 7701.3 7751.0 8459.1 8728.0 9139.5 9186.2 9219.4 8901.3 8980.9 9095.7 9105.6 9168.6 6610.8 6810.8 7011.7 7269.8 7365.8 7883.8 7885.0 7901.3 7930.3 7944.1 6949.6 7114.5 7168.5 7248.5 7358.9 6999.2 7017.4 7095.2 7114.5 7166.1 7398.8 7558.3 7606.4 7619.1 7622.1 7030.1 7077.7 7085.3 7090.3 7094.1 7098.1 7103.2 7169.2 7215.8 7221.1 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | [#4] prototype.html Cycles:180 Average:5339.29 Median:6036.14 stddev:1591.55 (26.4%) stddev-sans-first:1551.56 03:50:42 INFO - PROCESS | 6585 | Values: 362.6 364.8 365.1 365.8 369.5 5978.4 6008.9 6025.5 6036.0 6044.6 5927.2 5927.9 5939.6 5941.2 5943.5 4494.8 4545.4 4663.1 4675.8 4707.7 4675.0 4677.7 4693.8 4703.6 4703.7 4641.9 4649.8 4651.4 4651.9 4670.4 4457.7 4555.6 4643.4 4647.7 4664.4 4117.7 4130.0 4133.8 4137.6 4139.4 5646.7 5648.2 5650.3 5651.6 5655.7 5431.3 5436.5 5437.8 5441.4 5442.0 6288.3 6291.2 6292.1 6304.7 6306.5 4316.7 4442.0 4453.8 4457.7 4582.7 6478.2 6508.8 6540.4 6541.1 6546.9 4553.5 4554.5 4558.3 4560.3 4562.2 4622.4 4625.7 4628.9 4633.6 4633.8 5304.0 5304.4 5307.9 5317.9 5318.7 6106.2 6293.1 6329.6 6329.7 6347.0 1610.4 1616.3 1617.5 1629.6 1634.3 1037.2 1068.0 1076.8 1094.6 1098.8 6035.1 6036.3 6041.7 6042.6 6044.5 6458.7 6564.9 6568.6 6578.2 6588.7 6060.8 6092.2 6093.3 6093.3 6102.9 3488.4 3488.8 3519.3 3520.2 3525.4 6679.7 6688.0 6853.9 6856.7 6861.1 6744.8 6758.5 6767.0 6770.6 6780.4 6832.0 6832.7 6834.5 6838.6 6842.3 6584.5 6615.4 6621.5 6623.8 6626.5 6334.3 6466.7 6483.3 6488.8 6497.3 6732.8 6806.4 6842.7 6852.2 6870.4 4597.7 4620.2 4631.6 4640.2 4643.6 6580.2 6580.6 6587.1 6609.6 6609.9 6197.7 6423.0 6424.1 6435.0 6438.5 6355.8 6368.5 6368.6 6396.1 6403.2 6268.8 6271.2 6290.7 6296.5 6296.7 6426.1 6433.5 6451.7 6454.9 6456.3 6017.0 6123.3 6219.0 6308.3 6314.3 03:50:42 INFO - PROCESS | 6585 | 03:50:42 INFO - PROCESS | 6585 | [#5] yui.html Cycles:180 Average:14317.75 Median:24160.50 stddev:16091.22 (66.6%) stddev-sans-first:16104.38 03:50:42 INFO - PROCESS | 6585 | Values: 809.8 820.7 871.6 907.5 926.0 12931.9 13267.1 13277.3 13282.7 13289.9 12640.7 12653.9 12667.2 12680.6 12748.2 788.8 926.8 926.9 954.5 955.9 939.6 940.2 943.8 946.6 946.6 973.8 975.0 975.4 975.8 975.9 812.7 955.9 983.6 984.4 984.8 729.8 731.4 731.7 731.7 732.3 12889.9 12915.7 12936.5 12944.0 12953.4 13504.3 14029.7 14035.6 14135.4 14281.5 10661.4 10775.8 10959.1 11010.1 11038.8 3840.7 3871.8 3888.7 3902.6 3918.3 52351.2 52688.2 52755.5 52817.5 53088.2 11049.2 11254.8 11322.7 11441.6 11623.3 20384.1 20413.3 20424.5 20430.7 20433.5 7844.0 7876.4 7883.9 7952.5 8142.9 4351.6 4398.9 4412.8 4481.9 4491.1 3342.4 3349.9 3367.5 3385.9 3398.6 519.6 565.5 594.1 602.3 619.6 691.1 708.9 772.4 773.6 792.9 8194.3 8262.6 8425.4 8609.4 8914.0 663.0 667.5 745.9 754.4 771.4 4273.1 4311.5 4316.0 4366.0 4508.0 55260.7 57130.4 57714.7 58227.4 58302.0 50224.7 50822.0 51263.0 51291.2 51435.7 45053.3 45332.0 45358.3 45688.3 46006.5 8372.4 8406.2 8535.1 8773.6 8852.2 34942.3 35914.6 36221.1 36947.4 37061.6 41146.0 43955.0 44099.0 44543.0 44617.8 11029.5 12867.2 12936.4 13042.3 13539.5 13288.5 13590.9 14379.0 14482.0 14545.9 12845.2 13023.3 13024.5 13117.4 13319.6 12257.9 12333.4 12405.3 12439.6 12769.5 11551.7 11691.6 11713.8 11906.8 12111.3 10053.8 10575.6 10664.7 10669.5 11031.2 10014.7 10199.0 10426.9 10659.6 10816.3 03:50:42 INFO - PROCESS | 6585 | -------- Summary: end -------- 03:50:42 INFO - PROCESS | 6585 | 03:50:43 INFO - TEST-INFO | 6585: exit 0 03:50:43 INFO - TEST-OK | dromaeo_css | took 1112344ms 03:50:43 INFO - TEST-START | kraken 03:50:43 INFO - operating with platform_type : linux_ 03:50:43 INFO - Initialising browser for kraken test... 03:50:43 INFO - TEST-INFO | started process 6770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwKrnq2/profile http://localhost:36935/getInfo.html) 03:50:47 INFO - PROCESS | 6770 | __metrics Screen width/height:1600/1200 03:50:47 INFO - PROCESS | 6770 | colorDepth:24 03:50:47 INFO - PROCESS | 6770 | Browser inner width/height: 1024/697 03:50:47 INFO - PROCESS | 6770 | __metrics 03:50:48 INFO - PROCESS | 6770 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:50:49 INFO - TEST-INFO | 6770: exit 0 03:50:49 INFO - Browser initialized. 03:50:49 INFO - Running cycle 1/1 for kraken test... 03:50:49 INFO - TEST-INFO | started process 6860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwKrnq2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:01 INFO - PROCESS | 6860 | RSS: Main: 141406208 03:51:01 INFO - PROCESS | 6860 | 03:51:03 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36935/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:04 INFO - PROCESS | 6860 | RSS: Main: 177623040 03:51:04 INFO - PROCESS | 6860 | 03:51:06 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36935/tests/kraken/driver.html?testName=audio-dft) 03:51:07 INFO - PROCESS | 6860 | RSS: Main: 176238592 03:51:07 INFO - PROCESS | 6860 | 03:51:10 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36935/tests/kraken/driver.html?testName=audio-fft) 03:51:10 INFO - PROCESS | 6860 | RSS: Main: 174039040 03:51:10 INFO - PROCESS | 6860 | 03:51:12 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36935/tests/kraken/driver.html?testName=audio-oscillator) 03:51:13 INFO - PROCESS | 6860 | RSS: Main: 175517696 03:51:13 INFO - PROCESS | 6860 | 03:51:15 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:16 INFO - PROCESS | 6860 | RSS: Main: 172113920 03:51:16 INFO - PROCESS | 6860 | 03:51:19 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36935/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:19 INFO - PROCESS | 6860 | RSS: Main: 173023232 03:51:19 INFO - PROCESS | 6860 | 03:51:23 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36935/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:23 INFO - PROCESS | 6860 | RSS: Main: 172756992 03:51:23 INFO - PROCESS | 6860 | 03:51:26 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36935/tests/kraken/driver.html?testName=json-parse-financial) 03:51:26 INFO - PROCESS | 6860 | RSS: Main: 172519424 03:51:26 INFO - PROCESS | 6860 | 03:51:28 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:29 INFO - PROCESS | 6860 | RSS: Main: 177184768 03:51:29 INFO - PROCESS | 6860 | 03:51:30 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:31 INFO - PROCESS | 6860 | RSS: Main: 175222784 03:51:31 INFO - PROCESS | 6860 | 03:51:33 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:34 INFO - PROCESS | 6860 | RSS: Main: 180867072 03:51:34 INFO - PROCESS | 6860 | 03:51:36 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:37 INFO - PROCESS | 6860 | RSS: Main: 188407808 03:51:37 INFO - PROCESS | 6860 | 03:51:39 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:40 INFO - PROCESS | 6860 | RSS: Main: 188276736 03:51:40 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:36935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36935/tests/kraken/driver.html?testName=ai-astar) 03:51:41 INFO - PROCESS | 6860 | RSS: Main: 250531840 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | __start_tp_report 03:51:41 INFO - PROCESS | 6860 | _x_x_mozilla_page_load 03:51:41 INFO - PROCESS | 6860 | _x_x_mozilla_page_load_details 03:51:41 INFO - PROCESS | 6860 | |i|pagename|runs| 03:51:41 INFO - PROCESS | 6860 | |0;ai-astar;112;111;107;109;110;111;99;109;108;108 03:51:41 INFO - PROCESS | 6860 | |1;audio-beat-detection;157;129;157;164;127;155;155;129;177;128 03:51:41 INFO - PROCESS | 6860 | |2;audio-dft;161;162;162;162;161;160;160;163;160;160 03:51:41 INFO - PROCESS | 6860 | |3;audio-fft;75;76;76;165;77;76;75;73;163;75 03:51:41 INFO - PROCESS | 6860 | |4;audio-oscillator;93;93;145;92;93;92;144;92;92;146 03:51:41 INFO - PROCESS | 6860 | |5;imaging-gaussian-blur;116;116;116;116;117;116;116;117;117;117 03:51:41 INFO - PROCESS | 6860 | |6;imaging-darkroom;148;146;146;145;146;146;145;145;146;145 03:51:41 INFO - PROCESS | 6860 | |7;imaging-desaturate;96;96;95;95;96;95;95;95;96;95 03:51:41 INFO - PROCESS | 6860 | |8;json-parse-financial;56;57;56;56;56;56;55;64;55;55 03:51:41 INFO - PROCESS | 6860 | |9;json-stringify-tinderbox;63;64;63;66;64;63;64;64;64;64 03:51:41 INFO - PROCESS | 6860 | |10;stanford-crypto-aes;78;78;77;76;78;78;79;77;78;78 03:51:41 INFO - PROCESS | 6860 | |11;stanford-crypto-ccm;114;110;110;127;111;112;111;112;110;120 03:51:41 INFO - PROCESS | 6860 | |12;stanford-crypto-pbkdf2;142;136;134;135;137;123;146;135;138;136 03:51:41 INFO - PROCESS | 6860 | |13;stanford-crypto-sha256-iterative;65;67;67;66;67;66;68;64;63;63 03:51:41 INFO - PROCESS | 6860 | __end_tp_report 03:51:41 INFO - PROCESS | 6860 | __start_cc_report 03:51:41 INFO - PROCESS | 6860 | _x_x_mozilla_cycle_collect,1063 03:51:41 INFO - PROCESS | 6860 | __end_cc_report 03:51:41 INFO - PROCESS | 6860 | __startTimestamp1461408701947__endTimestamp 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | ------- Summary: start ------- 03:51:41 INFO - PROCESS | 6860 | Number of tests: 14 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:3.66 (3.3%) stddev-sans-first:3.64 03:51:41 INFO - PROCESS | 6860 | Values: 112.0 111.0 107.0 109.0 110.0 111.0 99.0 109.0 108.0 108.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:156.00 stddev:18.01 (11.5%) stddev-sans-first:18.79 03:51:41 INFO - PROCESS | 6860 | Values: 157.0 129.0 157.0 164.0 127.0 155.0 155.0 129.0 177.0 128.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 03:51:41 INFO - PROCESS | 6860 | Values: 161.0 162.0 162.0 162.0 161.0 160.0 160.0 163.0 160.0 160.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.50 stddev:37.39 (49.5%) stddev-sans-first:39.08 03:51:41 INFO - PROCESS | 6860 | Values: 75.0 76.0 76.0 165.0 77.0 76.0 75.0 73.0 163.0 75.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.00 stddev:25.40 (27.6%) stddev-sans-first:26.34 03:51:41 INFO - PROCESS | 6860 | Values: 93.0 93.0 145.0 92.0 93.0 92.0 144.0 92.0 92.0 146.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:51:41 INFO - PROCESS | 6860 | Values: 116.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.53 03:51:41 INFO - PROCESS | 6860 | Values: 148.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:51:41 INFO - PROCESS | 6860 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.67 (4.8%) stddev-sans-first:2.83 03:51:41 INFO - PROCESS | 6860 | Values: 56.0 57.0 56.0 56.0 56.0 56.0 55.0 64.0 55.0 55.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 03:51:41 INFO - PROCESS | 6860 | Values: 63.0 64.0 63.0 66.0 64.0 63.0 64.0 64.0 64.0 64.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 03:51:41 INFO - PROCESS | 6860 | Values: 78.0 78.0 77.0 76.0 78.0 78.0 79.0 77.0 78.0 78.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:112.00 stddev:5.56 (5.0%) stddev-sans-first:5.89 03:51:41 INFO - PROCESS | 6860 | Values: 114.0 110.0 110.0 127.0 111.0 112.0 111.0 112.0 110.0 120.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:136.50 stddev:5.92 (4.3%) stddev-sans-first:5.90 03:51:41 INFO - PROCESS | 6860 | Values: 142.0 136.0 134.0 135.0 137.0 123.0 146.0 135.0 138.0 136.0 03:51:41 INFO - PROCESS | 6860 | 03:51:41 INFO - PROCESS | 6860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.50 stddev:1.78 (2.7%) stddev-sans-first:1.87 03:51:41 INFO - PROCESS | 6860 | Values: 65.0 67.0 67.0 66.0 67.0 66.0 68.0 64.0 63.0 63.0 03:51:41 INFO - PROCESS | 6860 | -------- Summary: end -------- 03:51:41 INFO - PROCESS | 6860 | 03:51:42 INFO - TEST-INFO | 6860: exit 0 03:51:42 INFO - TEST-OK | kraken | took 59684ms 03:51:42 INFO - SUITE-END | took 1172s 03:51:43 INFO - Completed test suite (00:19:32) 03:51:43 INFO - javascript benchmark 03:51:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3263.7225835803956, 3346.0129261867746, 3361.1765117546206, 3364.5626068611077, 3393.881214157504, 5401.486858748418, 5403.297571315728, 5409.080456322425, 5454.045542030144, 5473.31583552056, 5411.621186516945, 5434.184872269162, 5443.891122177554, 5445.210444485557, 5454.672719636825, 4799.664023518355, 4885.877853053676, 4928.162212423878, 4987.75061246938, 4996.575291100261, 4884.096442158212, 4933.383327084114, 4958.404991401037, 4979.502049795028, 5014.147594908874, 4984.152694042022, 4988.725620090893, 5004.224345226496, 5005.874853128683, 5023.372078490189, 4831.661783675144, 4937.0, 4962.702237865739, 4994.001199760044, 5008.974955125219, 4866.610671146335, 4931.753412329369, 4938.9012219755405, 4939.382577177853, 4960.90078198434, 5226.503482169188, 5238.371395432534, 5250.133727934886, 5266.710330931797, 5306.0, 5654.151877218409, 5775.451332123442, 5777.335606405275, 5777.5666824987875, 5789.334226563915, 5850.239468869062, 5851.093080572518, 5852.385499522531, 5871.148683440877, 5900.763969441217, 5461.699606521679, 5470.890582188374, 5481.862953426196, 5482.122860342366, 5484.287042684466, 5812.709364531841, 5926.1999630049395, 5943.702814859326, 5960.314563825129, 6021.0, 5766.798162064308, 5785.623934444247, 5802.564807639359, 5803.042497987784, 5805.274340707411, 5823.592348535646, 5837.503812175928, 5838.095095260242, 5876.882462350729, 5880.117982302689, 5630.408807075198, 5766.0, 5787.2187254720075, 5849.356570777211, 5854.882902341929, 5762.538996880239, 5776.364599894008, 5797.391273916178, 5802.47777700009, 5804.245448091806, 4325.113351762881, 4371.803268852909, 4377.5403582624, 4379.299312110047, 4398.186335527937, 3891.8248678809523, 3918.275119102918, 3959.7030222732833, 3973.920521589552, 3988.6210809973004, 5513.2005859151, 5517.61376703635, 5545.223668686387, 5555.3611334697025, 5563.36021357541, 5739.7704091836695, 5870.677112758839, 5902.970485147547, 5903.439173278532, 5907.084401917709, 5479.698616576047, 5527.53015993645, 5547.362053363834, 5562.721863906789, 5569.777208911679, 5012.824551140766, 5025.396952365666, 5043.949560504421, 5050.974745126251, 5071.0, 5812.622179558315, 5960.284765828128, 6046.939530604725, 6065.150878876961, 6066.666333351708, 5849.239598852122, 5858.443447872445, 5861.325947515919, 5878.882422351615, 5886.23478947734, 6017.247844019497, 6022.608530445507, 6032.60788048793, 6036.366181550874, 6038.184845045863, 5587.441255874543, 5693.089105743227, 5719.142128680564, 5759.0, 5783.508401785895, 5813.854653633693, 5828.504577110993, 5837.066069428871, 5844.386339434468, 5855.063189889597, 5684.232628595252, 5702.401247868914, 5710.172025056427, 5711.8000869969355, 5716.171155182392, 5610.495055444866, 5702.258706368311, 5712.714364281853, 5757.193992840922, 5772.451617096369, 5580.386157522588, 5616.550675945833, 5625.409332020243, 5628.549716022791, 5642.069058605284, 5715.399883012224, 5744.626599271034, 5753.338366087954, 5756.769729210785, 5757.424257574209, 5415.106507426231, 5451.454854514517, 5598.188262701804, 5603.551715862803, 5613.550915926634], "unit": "score", "name": "dojo.html", "value": 5370.662325262927}, {"lowerIsBetter": false, "replicates": [561.2255087978589, 569.5529009727362, 579.9826005219845, 585.023011570677, 611.4710775179472, 39225.0, 39935.400968985414, 40004.399934000976, 40098.99999999996, 40102.59897401025, 43033.35449968245, 43676.781616091874, 43730.12539749203, 43751.56248437515, 43805.7809710951, 8786.297096232302, 8969.237614802749, 8971.327150463709, 9018.278537717, 9022.052684468135, 8961.820763584725, 9150.816983660323, 9179.219766319871, 9180.632774689004, 9185.311101667368, 9173.40372875761, 9337.0, 9337.813243735121, 9350.532473376337, 9352.625894964192, 9157.267418606496, 9166.679166229216, 9210.49342286174, 9263.953680231623, 9288.535573221312, 9074.818503629956, 9207.815843683089, 9211.447313161232, 9238.769030774285, 9239.029901860342, 41914.0, 42539.57460425418, 42584.574154258684, 42588.787056064524, 42614.57385426137, 3731.421629647409, 3798.411246256807, 3891.6302951219873, 4051.007503161715, 4238.87283381499, 32540.18649533757, 32790.83604581986, 32993.835030824936, 33068.6693133068, 33500.162495937555, 4151.8962025949595, 4190.53904070552, 4262.701610887239, 4302.612764851178, 4368.650507959355, 286504.0, 287257.0, 288052.5597372021, 288256.5587172051, 288283.0, 45086.32370514445, 45983.5401645986, 60902.69548652229, 61646.0, 61695.383046168965, 44474.77762611231, 44840.55159448364, 44870.551294486635, 45087.32369014467, 45163.548364516595, 14560.126392416489, 14728.779068313985, 14736.705265894621, 14737.631559211106, 14756.926215368854, 11339.829902551468, 11380.374079425546, 11409.48657310423, 11410.543578256942, 11418.371989540656, 15238.466653667068, 15629.921850390676, 15772.447964321194, 15785.36858525669, 15791.0, 5841.88316233673, 5958.970205148947, 6136.662483563447, 6200.0079987202735, 6233.96883015582, 1011.9747006324901, 1049.375621505203, 1067.8077945969644, 1100.2573263047411, 1180.7756526259984, 29728.702712972594, 29785.40429191404, 29838.40323193524, 30504.694953050184, 30657.846710766302, 1152.5101831721486, 1168.3574034281282, 1174.518447436547, 1183.988160118388, 1202.2305724336431, 15289.515718263177, 15909.363625455084, 16017.759733604005, 16063.357465701474, 16164.27260773268, 336742.0, 339309.0, 340439.0, 340897.0, 341191.0, 55781.0, 56353.43646563564, 56360.0, 56397.15404268939, 56447.435525645036, 1254.4668515880714, 1337.5920344294889, 1442.8917831162705, 1490.3740429019838, 1503.3460444706589, 27838.721612784422, 27981.0, 28099.0, 28107.437851242452, 28448.857755711088, 42135.36796947987, 42279.788601056796, 42446.78776606221, 42609.36085958651, 42619.360709588764, 190897.0, 228618.0, 229044.0, 229814.0, 229859.0, 30372.84813575918, 34692.653073469955, 34890.65109348874, 34907.127321817155, 35054.824725876206, 41070.0, 41697.79151104225, 41770.0, 42811.0, 42862.57137428586, 37299.62700372961, 37443.25113497769, 38102.0, 38275.42586861143, 38291.234175316895, 37195.25609487849, 37819.81090094642, 37820.0, 37869.62130378661, 38332.425013625376, 37633.62366376301, 37740.43389349217, 38110.23779524338, 38630.42054369243, 38810.22379552449, 33109.83445082759, 34282.0, 34299.82850085734, 34596.30807383788, 34601.307973840885, 26068.217953461426, 26456.0, 26598.202053938414, 26700.30715226029, 26716.465670686088], "unit": "score", "name": "ext.html", "value": 18628.265863676363}, {"lowerIsBetter": false, "replicates": [390.8475694479152, 393.69685342286436, 394.8795617336711, 396.2530629762897, 406.31941497990874, 18624.534386640342, 18798.624027519443, 18829.811701882976, 19459.902700486513, 19474.707879381804, 13390.397432115555, 14243.572692819205, 17462.82537174628, 18294.451166464994, 18566.535836604093, 5460.808871689492, 5610.579206559504, 5636.436356364372, 5643.943560564403, 5645.520130788888, 4259.659227261812, 5473.75368108436, 5625.80309689161, 5665.971670141644, 5682.232898558704, 4241.639460645849, 5614.0, 5636.549076073925, 5953.493953013999, 6170.167027451282, 6127.172831667713, 6135.447809697104, 6143.170671959273, 6160.1683772690785, 6168.845778855542, 5299.894002119936, 5442.265294185274, 5489.149181876815, 5502.284702988626, 5505.119180931072, 20628.071736771883, 21313.786862131336, 21415.14339426421, 21431.357059288246, 21525.0, 2357.9174728884577, 2683.973160268392, 2759.0, 2781.401998570317, 2814.7326004029787, 13680.247586382746, 13707.931460342734, 13813.585592432242, 13895.0, 14119.717605647933, 1923.2691577200715, 1981.3758666020158, 1988.2444671024919, 1993.800619938009, 2035.6946458031266, 64337.356626433604, 65633.3436665632, 65849.0, 66105.3389466104, 66349.66825165843, 9995.450250236161, 10130.44282564466, 10284.125849302744, 10299.742506437398, 10379.63671271517, 14670.633234169018, 14732.116073035651, 14781.33483993223, 14787.704245915022, 14792.556223313319, 7458.664360103809, 7519.548827070394, 7624.19945905683, 7690.577018263937, 7705.961470192613, 7143.607101609461, 7180.102487189101, 7210.170830354471, 7228.457865660096, 7315.231900650461, 6106.664133472613, 6155.6614386209185, 6213.813585592439, 6243.906341404791, 6330.6201627901555, 1941.5340318323783, 1959.3534133736118, 1968.1756679165157, 1981.2174191194686, 1990.4924244317606, 1094.3379255550437, 1096.1614365010773, 1120.7254222715324, 1157.9305241685527, 1184.9052075833913, 16362.34550617962, 17562.121893905252, 17575.20911558983, 17752.0, 17768.46694599164, 1037.8754549453963, 1074.8495210670512, 1091.924454412403, 1093.8195197792434, 1113.9610113646145, 10256.38461692301, 10448.477576121164, 10468.52891619879, 10471.214658900613, 10519.368837869599, 343398.0, 345530.0, 347770.0, 348833.0, 433830.0, 66878.0, 68691.31308686949, 70258.2974170262, 72218.2778172222, 73036.26963730295, 1053.4574694032578, 1060.211643377911, 1076.1390887290136, 1077.7682798198268, 1089.9237053406187, 15643.687126257639, 15698.450554230547, 15698.607534811721, 15871.2064396782, 15948.521544353687, 33700.0, 34825.47761783525, 35017.29965400627, 35517.46723799093, 35697.82151089228, 49133.0, 49168.50831491639, 49223.75388123036, 49287.50712492829, 49964.50035499599, 8135.30849877767, 8151.0, 8291.95854020726, 8294.129116442688, 8367.707130250412, 11779.469923853276, 12602.0, 12962.740745185232, 13008.674783130498, 13064.54274100402, 10498.842517362398, 11207.66377008691, 11412.258203216765, 11432.599859004895, 11847.052235821286, 10596.205284603531, 10708.411037392707, 10888.128949684165, 11189.440527973406, 11585.710357241136, 11475.368854712737, 11560.537578496765, 11574.826377604175, 11661.6501504955, 11728.061755059403, 8367.07962124178, 8485.95757021211, 8550.1449855014, 8605.741827745178, 8720.738377848675, 9048.9234455707, 10991.725206869893, 11164.218504704917, 11369.772604548029, 11695.415229238673], "unit": "score", "name": "jquery.html", "value": 8922.540208045417}, {"lowerIsBetter": false, "replicates": [1510.4939845151873, 1594.62526306318, 1601.6636506333668, 1851.7592712947314, 1954.9315773947915, 7948.364130869524, 8141.837163256731, 8144.552049637267, 8149.225823546753, 8153.510789352636, 8041.7185398511065, 8209.055958564766, 8210.137935516774, 8211.973503312085, 8214.671413143482, 2023.8988050597484, 2321.0367697405554, 2343.5078633486987, 2449.4856080223176, 2512.170983575416, 2471.233917485585, 2482.900683972639, 2488.6764720586298, 2492.8753562321904, 2502.699676038878, 2449.2529778417575, 2482.5531404347303, 2486.3908342456034, 2488.415222422729, 2489.601663733803, 2376.5009348036933, 2424.4302588891596, 2435.8538487690794, 2438.0247900839718, 2438.7195472520534, 2393.1384701507445, 2399.1003373734848, 2458.9754102459106, 2467.247489515697, 2468.8888999995042, 8319.334453243726, 8371.95814020926, 8378.622961966727, 8379.70671026511, 8382.538960357178, 5074.213496907948, 5200.063988482072, 5234.6335756497065, 5242.9213561796605, 5253.52718255355, 3278.655741147169, 3351.245969656832, 3518.1732292911147, 3527.1182204448887, 3528.576570811493, 1009.6264382178641, 1034.92884864166, 1035.5391850626474, 1054.5412745455674, 1115.3530952047875, 11688.0, 11698.766024679544, 11705.12211584126, 11705.941470292679, 11714.414279286002, 4742.857714268577, 4800.402748163903, 4826.7827947742435, 4842.5157484251995, 4864.148773964542, 9819.410835349901, 9828.459434731158, 9834.164096051916, 9847.96596357372, 9851.0, 4669.7431641260055, 5344.652597581145, 5382.73086345689, 5392.838214853561, 5398.379186393615, 4328.61042506176, 4810.254410566367, 4846.854594362175, 4888.802243450306, 4903.141950158708, 3924.9215015699524, 3993.0217096810884, 4012.057166565855, 4041.6160464755803, 4042.4542686737504, 1332.6734949937133, 1338.7924871644911, 1346.0, 1356.7964805279287, 1358.517726207202, 1423.0963338280267, 1438.5324769449762, 1464.8901332400112, 1501.369424841569, 1510.0, 7849.686012559548, 7898.4865983712025, 8040.316573091236, 8062.1937806220085, 8086.150954149847, 1194.235689158939, 1220.5972029230334, 1244.3388076917236, 1246.2086575024925, 1273.7325161716144, 6236.844078897973, 6251.249850018027, 6293.811185664437, 6326.43062124411, 6327.430531252209, 9911.207103431709, 10220.386776793417, 10351.534180961875, 10371.222158338154, 10391.168706503462, 10009.398496240567, 10078.244131690153, 10133.797324053477, 10158.187345012382, 10203.38779673222, 8018.518888866687, 8022.197780221931, 8046.637901294456, 8075.717349892608, 8123.512589244664, 7612.961935190288, 7637.350825179699, 7685.03937007874, 7701.268379503938, 7750.961245193738, 8459.111793261618, 8728.0, 9139.497327646777, 9186.173244408035, 9219.44683319003, 8901.33240007015, 8980.910190898006, 9095.681651142442, 9105.635774568944, 9168.587413566273, 6610.8347291318105, 6810.761623343357, 7011.719531218694, 7269.818254543467, 7365.8158546036775, 7883.763487095396, 7884.960575197088, 7901.328387087162, 7930.325922296669, 7944.086430060617, 6949.583025018515, 7114.466415018791, 7168.53404528704, 7248.456365772483, 7358.889616655862, 6999.160100787938, 7017.403520700594, 7095.184053833876, 7114.50198486101, 7166.068411106523, 7398.778036658909, 7558.319751222416, 7606.391488681003, 7619.123800762984, 7622.085349758065, 7030.121234845645, 7077.681504332214, 7085.326893945067, 7090.290970902868, 7094.148702155774, 7098.148222213367, 7103.183133939663, 7169.175544812413, 7215.819604509929, 7221.061262035902], "unit": "score", "name": "mootools.html", "value": 4872.1917526543}, {"lowerIsBetter": false, "replicates": [362.55767963085043, 364.77201748906924, 365.0909236002354, 365.77504834526775, 369.4513647233857, 5978.372270911557, 6008.939910600892, 6025.457708806207, 6036.0, 6044.607100538473, 5927.199828023216, 5927.940720592804, 5939.643621382709, 5941.227640406741, 5943.465088142067, 4494.8202071917085, 4545.386372839674, 4663.090697314025, 4675.789589468465, 4707.717536947777, 4675.0, 4677.74272415017, 4693.8357157499495, 4703.623710103184, 4703.741294228816, 4641.9071618567605, 4649.814007439699, 4651.3720647712635, 4651.930221046687, 4670.392848929634, 4457.732536047832, 4555.589996900295, 4643.3731446255, 4647.744374059425, 4664.393628828265, 4117.691173161995, 4129.958700412987, 4133.834646614132, 4137.586241375869, 4139.3583994480905, 5646.661200327993, 5648.237487939116, 5650.265465489501, 5651.632643878176, 5655.660660360391, 5431.348238211401, 5436.483534064258, 5437.8368648940595, 5441.374241962146, 5442.047641662693, 6288.276848162474, 6291.245050593958, 6292.056191571255, 6304.747810087637, 6306.527010474187, 4316.740995540277, 4442.0, 4453.844115455943, 4457.710248833815, 4582.702124361906, 6478.190226221723, 6508.8047358579315, 6540.37866402691, 6541.084248205255, 6546.869062618769, 4553.54464553542, 4554.476235232991, 4558.270676691714, 4560.293154561048, 4562.1560011398, 4622.352870598119, 4625.676202665781, 4628.930566041512, 4633.559811817872, 4633.7683115844075, 5304.0, 5304.443033481506, 5307.893842123136, 5317.867053323621, 5318.680879147263, 6106.236720409949, 6293.087502312139, 6329.620222786648, 6329.715162817684, 6347.0479428086155, 1610.3961014619517, 1616.313066946543, 1617.5309160343604, 1629.576310159367, 1634.3380930723076, 1037.1961729659574, 1067.989320106789, 1076.8438576406377, 1094.584058057933, 1098.7967226063204, 6035.1249068885645, 6036.275646922398, 6041.72812223451, 6042.577019608585, 6044.486218671462, 6458.6770661466735, 6564.934350656527, 6568.638724870178, 6578.243501997332, 6588.703508342136, 6060.757569697251, 6092.238470191226, 6093.26880774301, 6093.268807743099, 6102.877942441126, 3488.3720930232803, 3488.8081155536183, 3519.2609551993855, 3520.2431477232517, 3525.383057964897, 6679.732810687616, 6688.0, 6853.862922741617, 6856.725730970805, 6861.1080559526945, 6744.763933262312, 6758.493113016543, 6766.966165169143, 6770.593764374154, 6780.38976492118, 6832.0, 6832.6925288362145, 6834.4874134440115, 6838.555493892782, 6842.281560436182, 6584.50616203777, 6615.404613584608, 6621.50338724588, 6623.801285961429, 6626.503012274003, 6334.271558770801, 6466.676666166579, 6483.319251478527, 6488.837779055561, 6497.25281592604, 6732.831679208059, 6806.353396427331, 6842.657867106725, 6852.211995620368, 6870.381665649916, 4597.747123908217, 4620.168369693488, 4631.629469642353, 4640.211164102043, 4643.558861908114, 6580.243272023778, 6580.638064906476, 6587.077809106825, 6609.636469994004, 6609.900851487328, 6197.659128747962, 6423.0, 6424.100625912282, 6435.0, 6438.549301548846, 6355.841103972438, 6368.4586810121655, 6368.5860419072615, 6396.136521569529, 6403.167588213689, 6268.843278917881, 6271.184745983175, 6290.654014029273, 6296.496280297473, 6296.653684047421, 6426.132472116205, 6433.5496515243485, 6451.70967306463, 6454.903176452263, 6456.2575303838785, 6017.0, 6123.326434092157, 6219.0, 6308.306086330592, 6314.273858506147], "unit": "score", "name": "prototype.html", "value": 4828.979853631462}, {"lowerIsBetter": false, "replicates": [809.7773112394093, 820.6963423533293, 871.6077765005749, 907.4918045894295, 926.0415469988559, 12931.935340323296, 13267.071305008652, 13277.269750163738, 13282.7343453131, 13289.867101328984, 12640.747185056316, 12653.873461265384, 12667.176633518839, 12680.61958141255, 12748.235105893653, 788.8185717285028, 926.7729406295467, 926.8609708543722, 954.4893481987139, 955.9426434413957, 939.5584075484511, 940.1538615246264, 943.8489841625342, 946.5882341181574, 946.6308139825439, 973.8198433289864, 975.0493269062642, 975.3708857786723, 975.7999610079952, 975.9316847820655, 812.7317985064915, 955.8518429643416, 983.6360546597733, 984.4388698441891, 984.7784248544092, 729.8321386081178, 731.3527528137583, 731.6707481633287, 731.6780616528711, 732.2750477027704, 12889.871101289054, 12915.67710807228, 12936.547220847226, 12944.0, 12953.352332383343, 13504.324783760772, 14029.719405611831, 14035.578932632037, 14135.434582616683, 14281.500147494788, 10661.413622250773, 10775.83836242457, 10959.06847917928, 11010.119190464744, 11038.779224415546, 3840.692744580455, 3871.806409679533, 3888.7083468739675, 3902.570717221103, 3918.255531449044, 52351.21473177905, 52688.20967685488, 52755.47244527544, 52817.471825282024, 53088.203676944875, 11049.226554141133, 11254.774904501865, 11322.660320190407, 11441.599544015919, 11623.302601843747, 20384.082716277804, 20413.285535006202, 20424.489387765425, 20430.69353959692, 20433.48916277105, 7844.0, 7876.427907161686, 7883.881741773878, 7952.483088599222, 8142.918570814216, 4351.586599273064, 4398.868033958986, 4412.757298348622, 4481.865544033684, 4491.124230775033, 3342.4484959981332, 3349.9162520936684, 3367.478040903664, 3385.9322813544086, 3398.6261511233743, 519.6076961893746, 565.5080080330057, 594.147398483178, 602.325395556979, 619.6065498408543, 691.1188235000315, 708.8972099045712, 772.3589420780851, 773.5513402226695, 792.8572856885701, 8194.262516373556, 8262.628181731836, 8425.410221284452, 8609.397342185986, 8914.031198114973, 663.0352836622702, 667.4726965697045, 745.8881167824869, 754.4379437319233, 771.4098714483424, 4273.081287523198, 4311.48262208537, 4316.028893498938, 4366.0, 4507.977460112678, 55260.72369638126, 57130.42869571251, 57714.7114264426, 58227.4177258222, 58302.0, 50224.74887625612, 50822.0, 51263.0, 51291.23063154056, 51435.742821285654, 45053.32420013702, 45332.0, 45358.31962520565, 45688.31467528056, 46006.53993460022, 8372.372072094739, 8406.201410866202, 8535.10381409943, 8773.605187766694, 8852.159044890725, 34942.30115397627, 35914.64085359113, 36221.0944726384, 36947.44578831266, 37061.59099658514, 41146.0, 43955.0, 44099.0, 44543.0, 44617.77691111524, 11029.46322345849, 12867.227966321676, 12936.417861196456, 13042.282674452996, 13539.458421663023, 13288.468461261442, 13590.93204533971, 14379.0, 14482.0, 14545.92727036358, 12845.229286242855, 13023.283719395524, 13024.54414095502, 13117.3927170029, 13319.600411987656, 12257.938710306391, 12333.444994975427, 12405.255684658949, 12439.626811195678, 12769.489220431078, 11551.71120721955, 11691.590794322157, 11713.765724685629, 11906.76186476283, 12111.273323600612, 10053.849192262269, 10575.576976920836, 10664.733381665521, 10669.519871605951, 11031.17266205054, 10014.699559013241, 10198.980101989742, 10426.947865260625, 10659.626913058006, 10816.296940698829], "unit": "score", "name": "yui.html", "value": 6755.832441848388}], "name": "dromaeo_css", "value": 7222.105083459849}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 107.0, 109.0, 110.0, 111.0, 99.0, 109.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 157.0, 164.0, 127.0, 155.0, 155.0, 129.0, 177.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 160.0, 160.0, 163.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 76.0, 165.0, 77.0, 76.0, 75.0, 73.0, 163.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 145.0, 92.0, 93.0, 92.0, 144.0, 92.0, 92.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 55.0, 64.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 66.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 77.0, 76.0, 78.0, 78.0, 79.0, 77.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [114.0, 110.0, 110.0, 127.0, 111.0, 112.0, 111.0, 112.0, 110.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.7}, {"lowerIsBetter": true, "replicates": [142.0, 136.0, 134.0, 135.0, 137.0, 123.0, 146.0, 135.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 67.0, 66.0, 67.0, 66.0, 68.0, 64.0, 63.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1489.9000000000003}]} 03:51:43 INFO - Return code: 0 03:51:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:51:43 INFO - # TBPL SUCCESS # 03:51:43 INFO - Running post-action listener: _resource_record_post_action 03:51:43 INFO - Running post-run listener: _resource_record_post_run 03:51:44 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 475136; Write bytes: 251629568; Read time: 184; Write time: 141856 03:51:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1277952; Read time: 0; Write time: 52 03:51:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 475136; Write bytes: 250351616; Read time: 184; Write time: 141804 03:51:44 INFO - Running post-run listener: _upload_blobber_files 03:51:44 INFO - Blob upload gear active. 03:51:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:45 INFO - (blobuploader) - INFO - Done attempting. 03:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:46 INFO - (blobuploader) - INFO - Done attempting. 03:51:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:46 INFO - Return code: 0 03:51:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b2057f364cc9e9fdb14d509565750e4320ec829b76ea558304b198eaeb6074f1fb24615443a416bbd3ce646afe952338f29a27570547170932a0144aa7ef58c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21925a48e1805bfc07e02b9a390bb58f9ce6e1e05394f5d76b4d4d71bc15195590942bd53f0fad96ebc00a4cce31dfca2ce6ab745bffb53869b1e2d8d78b6261"} 03:51:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:46 INFO - Contents: 03:51:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b2057f364cc9e9fdb14d509565750e4320ec829b76ea558304b198eaeb6074f1fb24615443a416bbd3ce646afe952338f29a27570547170932a0144aa7ef58c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21925a48e1805bfc07e02b9a390bb58f9ce6e1e05394f5d76b4d4d71bc15195590942bd53f0fad96ebc00a4cce31dfca2ce6ab745bffb53869b1e2d8d78b6261"} 03:51:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:46 INFO - Copying logs to upload dir... 03:51:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.603220 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-23 03:51:46.256268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:46.260219) ========= 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=7de08804244eb36560b44971000001c3-1461407314.100011-1997916193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b2057f364cc9e9fdb14d509565750e4320ec829b76ea558304b198eaeb6074f1fb24615443a416bbd3ce646afe952338f29a27570547170932a0144aa7ef58c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21925a48e1805bfc07e02b9a390bb58f9ce6e1e05394f5d76b4d4d71bc15195590942bd53f0fad96ebc00a4cce31dfca2ce6ab745bffb53869b1e2d8d78b6261"} build_url:https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011107 build_url: 'https://queue.taskcluster.net/v1/task/atOnfwHKRmeHWOJq8m77aQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b2057f364cc9e9fdb14d509565750e4320ec829b76ea558304b198eaeb6074f1fb24615443a416bbd3ce646afe952338f29a27570547170932a0144aa7ef58c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21925a48e1805bfc07e02b9a390bb58f9ce6e1e05394f5d76b4d4d71bc15195590942bd53f0fad96ebc00a4cce31dfca2ce6ab745bffb53869b1e2d8d78b6261"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:46.290199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:46.290547) ========= 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=7de08804244eb36560b44971000001c3-1461407314.100011-1997916193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004325 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:51:46.373664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 03:51:46.374010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 03:51:46.374336) ========= ========= Total master_lag: 0.20 =========