builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1469648394.99 results: success (0) buildid: 20160727112326 builduid: caacdd874bb24a85b99bde7b96a3160a revision: 3039b674a5a44844eb47f327ca7378d800eeb15d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:54.989603) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:54.990114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:54.990400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:55.008374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:55.008763) ========= 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=33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 12:39:55-- 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% 46.5M=0s 2016-07-27 12:39:55 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:55.108462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:55.108853) ========= 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=33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:55.159170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 12:39:55.159537) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3039b674a5a44844eb47f327ca7378d800eeb15d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 3039b674a5a44844eb47f327ca7378d800eeb15d --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=33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 12:39:55,368 truncating revision to first 12 chars 2016-07-27 12:39:55,369 Setting DEBUG logging. 2016-07-27 12:39:55,369 attempt 1/10 2016-07-27 12:39:55,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3039b674a5a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 12:39:56,541 unpacking tar archive at: autoland-3039b674a5a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.487865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 12:39:56.661324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:56.661682) ========= script_repo_revision: 3039b674a5a44844eb47f327ca7378d800eeb15d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:56.662116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:56.662463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 12:39:56.671295) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-27 12:39:56.671654) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:56 INFO - MultiFileLogger online at 20160727 12:39:56 in /builds/slave/test 12:39:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:39:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:56 INFO - {'append_to_log': False, 12:39:56 INFO - 'base_work_dir': '/builds/slave/test', 12:39:56 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:39:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:56 INFO - 'branch': 'Autoland-Non-PGO', 12:39:56 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:56 INFO - 'config_files': ('talos/linux_config.py',), 12:39:56 INFO - 'default_actions': ('clobber', 12:39:56 INFO - 'read-buildbot-config', 12:39:56 INFO - 'download-and-extract', 12:39:56 INFO - 'populate-webroot', 12:39:56 INFO - 'create-virtualenv', 12:39:56 INFO - 'install', 12:39:56 INFO - 'run-tests'), 12:39:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:56 INFO - 'download_minidump_stackwalk': True, 12:39:56 INFO - 'download_symbols': 'ondemand', 12:39:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:56 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:56 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:56 INFO - 'installer_path': 'installer.exe', 12:39:56 INFO - 'log_level': 'info', 12:39:56 INFO - 'log_name': 'talos', 12:39:56 INFO - 'log_to_console': True, 12:39:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:56 INFO - 'opt_config_files': (), 12:39:56 INFO - 'pip_index': False, 12:39:56 INFO - 'sps_profile': False, 12:39:56 INFO - 'sps_profile_interval': 0, 12:39:56 INFO - 'suite': 'dromaeojs-e10s', 12:39:56 INFO - 'system_bits': '32', 12:39:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:56 INFO - 'title': 'talos-linux64-ix-063', 12:39:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:56 INFO - 'use_talos_json': True, 12:39:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:56 INFO - 'work_dir': 'build'} 12:39:56 INFO - [mozharness: 2016-07-27 19:39:56.969107Z] Running clobber step. 12:39:56 INFO - Running pre-action listener: _resource_record_pre_action 12:39:56 INFO - Running main action method: clobber 12:39:56 INFO - rmtree: /builds/slave/test/build 12:39:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:57 INFO - Running post-action listener: _resource_record_post_action 12:39:57 INFO - [mozharness: 2016-07-27 19:39:57.435412Z] Finished clobber step (success) 12:39:57 INFO - [mozharness: 2016-07-27 19:39:57.435512Z] Running read-buildbot-config step. 12:39:57 INFO - Running pre-action listener: _resource_record_pre_action 12:39:57 INFO - Running main action method: read_buildbot_config 12:39:57 INFO - Using buildbot properties: 12:39:57 INFO - { 12:39:57 INFO - "project": "", 12:39:57 INFO - "product": "firefox", 12:39:57 INFO - "script_repo_revision": "production", 12:39:57 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:39:57 INFO - "repository": "", 12:39:57 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 12:39:57 INFO - "buildid": "20160727112326", 12:39:57 INFO - "pgo_build": "False", 12:39:57 INFO - "basedir": "/builds/slave/test", 12:39:57 INFO - "buildnumber": 159, 12:39:57 INFO - "slavename": "talos-linux64-ix-063", 12:39:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:39:57 INFO - "platform": "ubuntu64_hw", 12:39:57 INFO - "scheduler": "tests-autoland-linux64-talos", 12:39:57 INFO - "branch": "autoland", 12:39:57 INFO - "repo_path": "integration/autoland", 12:39:57 INFO - "revision": "3039b674a5a44844eb47f327ca7378d800eeb15d", 12:39:57 INFO - "stage_platform": "linux64", 12:39:57 INFO - "builduid": "caacdd874bb24a85b99bde7b96a3160a", 12:39:57 INFO - "slavebuilddir": "test" 12:39:57 INFO - } 12:39:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:39:57 INFO - Running post-action listener: _resource_record_post_action 12:39:57 INFO - [mozharness: 2016-07-27 19:39:57.437977Z] Finished read-buildbot-config step (success) 12:39:57 INFO - [mozharness: 2016-07-27 19:39:57.438065Z] Running download-and-extract step. 12:39:57 INFO - Running pre-action listener: _resource_record_pre_action 12:39:57 INFO - Running main action method: download_and_extract 12:39:57 INFO - mkdir: /builds/slave/test/build/tests 12:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:57 INFO - https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:39:58 INFO - Downloaded 1361 bytes. 12:39:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:39:58 INFO - Using the following test package requirements: 12:39:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:39:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:39:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'jsshell-linux-x86_64.zip'], 12:39:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:39:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:39:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:39:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:58 INFO - https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:39:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:39:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:40:00 INFO - Downloaded 22746774 bytes. 12:40:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:40:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:40:01 INFO - Return code: 0 12:40:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:01 INFO - https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:40:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:40:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:40:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:40:02 INFO - Downloaded 22746774 bytes. 12:40:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:40:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:40:03 INFO - Return code: 0 12:40:03 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')]} 12:40:03 INFO - https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:40:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:40:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:40:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:40:05 INFO - Downloaded 14413725 bytes. 12:40:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:40:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:40:05 INFO - Return code: 0 12:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:05 INFO - https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:40:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:40:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:40:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:40:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:40:06 INFO - Downloaded 57159891 bytes. 12:40:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:40:06 INFO - mkdir: /builds/slave/test/properties 12:40:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:40:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:40:06 INFO - Contents: 12:40:06 INFO - build_url:https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:40:07 INFO - Running post-action listener: _resource_record_post_action 12:40:07 INFO - Running post-action listener: set_extra_try_arguments 12:40:07 INFO - [mozharness: 2016-07-27 19:40:07.399570Z] Finished download-and-extract step (success) 12:40:07 INFO - [mozharness: 2016-07-27 19:40:07.399802Z] Running populate-webroot step. 12:40:07 INFO - Running pre-action listener: _resource_record_pre_action 12:40:07 INFO - Running main action method: populate_webroot 12:40:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:40:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:40:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:40:07 INFO - '--tppagecycles', 12:40:07 INFO - '7'], 12:40:07 INFO - 'tests': ['tsvgm']}}, 12:40:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:40:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:40:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:40:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:40:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['damp', 'tps']}, 12:40:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'tests': ['damp', 'tps']}, 12:40:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['dromaeo_dom']}, 12:40:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:40:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['basic_compositor_video']}, 12:40:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:40:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['a11yr', 12:40:07 INFO - 'ts_paint', 12:40:07 INFO - 'tpaint', 12:40:07 INFO - 'sessionrestore', 12:40:07 INFO - 'sessionrestore_no_auto_restore', 12:40:07 INFO - 'tabpaint']}, 12:40:07 INFO - 'other-e10s': {'tests': ['a11yr', 12:40:07 INFO - 'ts_paint', 12:40:07 INFO - 'tpaint', 12:40:07 INFO - 'sessionrestore', 12:40:07 INFO - 'sessionrestore_no_auto_restore', 12:40:07 INFO - 'tabpaint']}, 12:40:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:40:07 INFO - 'ts_paint', 12:40:07 INFO - 'tpaint', 12:40:07 INFO - 'sessionrestore', 12:40:07 INFO - 'sessionrestore_no_auto_restore', 12:40:07 INFO - 'tabpaint']}, 12:40:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:40:07 INFO - 'ts_paint', 12:40:07 INFO - 'tpaint', 12:40:07 INFO - 'sessionrestore', 12:40:07 INFO - 'sessionrestore_no_auto_restore', 12:40:07 INFO - 'tabpaint']}, 12:40:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['a11yr', 12:40:07 INFO - 'ts_paint', 12:40:07 INFO - 'tpaint', 12:40:07 INFO - 'sessionrestore', 12:40:07 INFO - 'sessionrestore_no_auto_restore', 12:40:07 INFO - 'tabpaint']}, 12:40:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['a11yr', 12:40:07 INFO - 'ts_paint', 12:40:07 INFO - 'tpaint', 12:40:07 INFO - 'sessionrestore', 12:40:07 INFO - 'sessionrestore_no_auto_restore', 12:40:07 INFO - 'tabpaint']}, 12:40:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['tsvgx', 12:40:07 INFO - 'tsvgr_opacity', 12:40:07 INFO - 'tart', 12:40:07 INFO - 'tscrollx', 12:40:07 INFO - 'cart']}, 12:40:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:40:07 INFO - 'tsvgr_opacity', 12:40:07 INFO - 'tart', 12:40:07 INFO - 'tscrollx', 12:40:07 INFO - 'cart']}, 12:40:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'talos_options': ['--disable-e10s'], 12:40:07 INFO - 'tests': ['tp5o']}, 12:40:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'tests': ['tp5o']}, 12:40:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'talos_options': ['--disable-e10s', 12:40:07 INFO - '--xperf_path', 12:40:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:07 INFO - 'tests': ['tp5n']}, 12:40:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:07 INFO - 'talos_options': ['--xperf_path', 12:40:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:07 INFO - 'tests': ['tp5n']}}, 12:40:07 INFO - 'talos.zip': {'path': '', 12:40:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:40:07 INFO - Running post-action listener: _resource_record_post_action 12:40:07 INFO - [mozharness: 2016-07-27 19:40:07.418541Z] Finished populate-webroot step (success) 12:40:07 INFO - [mozharness: 2016-07-27 19:40:07.418630Z] Running create-virtualenv step. 12:40:07 INFO - Running pre-action listener: _resource_record_pre_action 12:40:07 INFO - Running main action method: create_virtualenv 12:40:07 INFO - Creating virtualenv /builds/slave/test/build/venv 12:40:07 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 12:40:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:40:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:40:07 INFO - Using real prefix '/usr' 12:40:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:40:08 INFO - Installing distribute.............................................................................................................................................................................................done. 12:40:09 INFO - Installing pip.................done. 12:40:10 INFO - Return code: 0 12:40:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:40:10 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')]} 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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')]} 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:10 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 12:40:10 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 12:40:10 INFO - Using env: {'DISPLAY': ':0', 12:40:10 INFO - 'HOME': '/home/cltbld', 12:40:10 INFO - 'LANG': 'en_US.UTF-8', 12:40:10 INFO - 'LANGUAGE': 'en_US:en', 12:40:10 INFO - 'LOGNAME': 'cltbld', 12:40:10 INFO - 'MAIL': '/var/mail/cltbld', 12:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:10 INFO - 'MOZ_NO_REMOTE': '1', 12:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:10 INFO - 'NO_EM_RESTART': '1', 12:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:10 INFO - 'PWD': '/builds/slave/test', 12:40:10 INFO - 'SHELL': '/bin/bash', 12:40:10 INFO - 'SHLVL': '1', 12:40:10 INFO - 'TERM': 'linux', 12:40:10 INFO - 'TMOUT': '86400', 12:40:10 INFO - 'USER': 'cltbld', 12:40:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:10 INFO - '_': '/tools/buildbot/bin/python'} 12:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:10 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 12:40:10 INFO - Cleaning up... 12:40:10 INFO - Return code: 0 12:40:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:40:10 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')]} 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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')]} 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:10 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:10 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>=3.1.1'] in /builds/slave/test/build 12:40:10 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>=3.1.1 12:40:10 INFO - Using env: {'DISPLAY': ':0', 12:40:10 INFO - 'HOME': '/home/cltbld', 12:40:10 INFO - 'LANG': 'en_US.UTF-8', 12:40:10 INFO - 'LANGUAGE': 'en_US:en', 12:40:10 INFO - 'LOGNAME': 'cltbld', 12:40:10 INFO - 'MAIL': '/var/mail/cltbld', 12:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:10 INFO - 'MOZ_NO_REMOTE': '1', 12:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:10 INFO - 'NO_EM_RESTART': '1', 12:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:10 INFO - 'PWD': '/builds/slave/test', 12:40:10 INFO - 'SHELL': '/bin/bash', 12:40:10 INFO - 'SHLVL': '1', 12:40:10 INFO - 'TERM': 'linux', 12:40:10 INFO - 'TMOUT': '86400', 12:40:10 INFO - 'USER': 'cltbld', 12:40:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:10 INFO - '_': '/tools/buildbot/bin/python'} 12:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:10 INFO - Downloading/unpacking psutil>=3.1.1 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:12 INFO - Installing collected packages: psutil 12:40:12 INFO - Running setup.py install for psutil 12:40:12 INFO - building 'psutil._psutil_linux' extension 12:40:12 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 12:40:12 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 12:40:12 INFO - building 'psutil._psutil_posix' extension 12:40:12 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 12:40:12 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 12:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:12 INFO - Successfully installed psutil 12:40:12 INFO - Cleaning up... 12:40:13 INFO - Return code: 0 12:40:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:40:13 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')]} 12:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:13 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')]} 12:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:13 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:13 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.3'] in /builds/slave/test/build 12:40:13 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.3 12:40:13 INFO - Using env: {'DISPLAY': ':0', 12:40:13 INFO - 'HOME': '/home/cltbld', 12:40:13 INFO - 'LANG': 'en_US.UTF-8', 12:40:13 INFO - 'LANGUAGE': 'en_US:en', 12:40:13 INFO - 'LOGNAME': 'cltbld', 12:40:13 INFO - 'MAIL': '/var/mail/cltbld', 12:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:13 INFO - 'MOZ_NO_REMOTE': '1', 12:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:13 INFO - 'NO_EM_RESTART': '1', 12:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:13 INFO - 'PWD': '/builds/slave/test', 12:40:13 INFO - 'SHELL': '/bin/bash', 12:40:13 INFO - 'SHLVL': '1', 12:40:13 INFO - 'TERM': 'linux', 12:40:13 INFO - 'TMOUT': '86400', 12:40:13 INFO - 'USER': 'cltbld', 12:40:13 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:13 INFO - '_': '/tools/buildbot/bin/python'} 12:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:40:15 INFO - Installing collected packages: mozsystemmonitor 12:40:15 INFO - Running setup.py install for mozsystemmonitor 12:40:15 INFO - Successfully installed mozsystemmonitor 12:40:15 INFO - Cleaning up... 12:40:15 INFO - Return code: 0 12:40:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:40:15 INFO - Using env: {'DISPLAY': ':0', 12:40:15 INFO - 'HOME': '/home/cltbld', 12:40:15 INFO - 'LANG': 'en_US.UTF-8', 12:40:15 INFO - 'LANGUAGE': 'en_US:en', 12:40:15 INFO - 'LOGNAME': 'cltbld', 12:40:15 INFO - 'MAIL': '/var/mail/cltbld', 12:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:15 INFO - 'MOZ_NO_REMOTE': '1', 12:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:15 INFO - 'NO_EM_RESTART': '1', 12:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:15 INFO - 'PWD': '/builds/slave/test', 12:40:15 INFO - 'SHELL': '/bin/bash', 12:40:15 INFO - 'SHLVL': '1', 12:40:15 INFO - 'TERM': 'linux', 12:40:15 INFO - 'TMOUT': '86400', 12:40:15 INFO - 'USER': 'cltbld', 12:40:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:15 INFO - '_': '/tools/buildbot/bin/python'} 12:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:15 INFO - Downloading/unpacking jsonschema==2.5.1 12:40:15 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 12:40:15 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 12:40:15 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 12:40:15 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 12:40:15 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 12:40:15 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 12:40:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:40:17 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 12:40:17 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 12:40:17 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 12:40:17 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 12:40:17 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 12:40:17 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 12:40:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:17 INFO - warning: no files found matching '*.txt' 12:40:17 INFO - no previously-included directories found matching 'build' 12:40:17 INFO - no previously-included directories found matching 'dist' 12:40:17 INFO - no previously-included directories found matching '.git*' 12:40:17 INFO - Installing collected packages: jsonschema, functools32 12:40:17 INFO - Running setup.py install for functools32 12:40:18 INFO - warning: no files found matching '*.txt' 12:40:18 INFO - no previously-included directories found matching 'build' 12:40:18 INFO - no previously-included directories found matching 'dist' 12:40:18 INFO - no previously-included directories found matching '.git*' 12:40:18 INFO - Successfully installed jsonschema functools32 12:40:18 INFO - Cleaning up... 12:40:18 INFO - Return code: 0 12:40:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:40:18 INFO - Using env: {'DISPLAY': ':0', 12:40:18 INFO - 'HOME': '/home/cltbld', 12:40:18 INFO - 'LANG': 'en_US.UTF-8', 12:40:18 INFO - 'LANGUAGE': 'en_US:en', 12:40:18 INFO - 'LOGNAME': 'cltbld', 12:40:18 INFO - 'MAIL': '/var/mail/cltbld', 12:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:18 INFO - 'MOZ_NO_REMOTE': '1', 12:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:18 INFO - 'NO_EM_RESTART': '1', 12:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:18 INFO - 'PWD': '/builds/slave/test', 12:40:18 INFO - 'SHELL': '/bin/bash', 12:40:18 INFO - 'SHLVL': '1', 12:40:18 INFO - 'TERM': 'linux', 12:40:18 INFO - 'TMOUT': '86400', 12:40:18 INFO - 'USER': 'cltbld', 12:40:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:18 INFO - '_': '/tools/buildbot/bin/python'} 12:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:40:18 INFO - Cleaning up... 12:40:18 INFO - Return code: 0 12:40:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:40:18 INFO - Using env: {'DISPLAY': ':0', 12:40:18 INFO - 'HOME': '/home/cltbld', 12:40:18 INFO - 'LANG': 'en_US.UTF-8', 12:40:18 INFO - 'LANGUAGE': 'en_US:en', 12:40:18 INFO - 'LOGNAME': 'cltbld', 12:40:18 INFO - 'MAIL': '/var/mail/cltbld', 12:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:18 INFO - 'MOZ_NO_REMOTE': '1', 12:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:18 INFO - 'NO_EM_RESTART': '1', 12:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:18 INFO - 'PWD': '/builds/slave/test', 12:40:18 INFO - 'SHELL': '/bin/bash', 12:40:18 INFO - 'SHLVL': '1', 12:40:18 INFO - 'TERM': 'linux', 12:40:18 INFO - 'TMOUT': '86400', 12:40:18 INFO - 'USER': 'cltbld', 12:40:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:18 INFO - '_': '/tools/buildbot/bin/python'} 12:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:40:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:40:20 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 12:40:20 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 12:40:20 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 12:40:20 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 12:40:20 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 12:40:20 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 12:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:20 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 12:40:20 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 12:40:20 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 12:40:20 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 12:40:20 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 12:40:20 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 12:40:21 INFO - Downloading docopt-0.6.1.tar.gz 12:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:21 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:21 INFO - Running setup.py install for blobuploader 12:40:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:21 INFO - Running setup.py install for requests 12:40:21 INFO - Running setup.py install for docopt 12:40:21 INFO - Successfully installed blobuploader requests docopt 12:40:21 INFO - Cleaning up... 12:40:21 INFO - Return code: 0 12:40:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:21 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 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:21 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 12:40:21 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 12:40:21 INFO - Using env: {'DISPLAY': ':0', 12:40:21 INFO - 'HOME': '/home/cltbld', 12:40:21 INFO - 'LANG': 'en_US.UTF-8', 12:40:21 INFO - 'LANGUAGE': 'en_US:en', 12:40:21 INFO - 'LOGNAME': 'cltbld', 12:40:21 INFO - 'MAIL': '/var/mail/cltbld', 12:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:21 INFO - 'MOZ_NO_REMOTE': '1', 12:40:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:21 INFO - 'NO_EM_RESTART': '1', 12:40:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:21 INFO - 'PWD': '/builds/slave/test', 12:40:21 INFO - 'SHELL': '/bin/bash', 12:40:21 INFO - 'SHLVL': '1', 12:40:21 INFO - 'TERM': 'linux', 12:40:21 INFO - 'TMOUT': '86400', 12:40:21 INFO - 'USER': 'cltbld', 12:40:21 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:21 INFO - '_': '/tools/buildbot/bin/python'} 12:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:22 INFO - Running setup.py (path:/tmp/pip-th6PbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:22 INFO - Running setup.py (path:/tmp/pip-1xf1UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:22 INFO - Running setup.py (path:/tmp/pip-nkM9so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:22 INFO - Running setup.py (path:/tmp/pip-DK1OfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:22 INFO - Running setup.py (path:/tmp/pip-1DbjAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:22 INFO - Running setup.py (path:/tmp/pip-EX_AQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:22 INFO - Running setup.py (path:/tmp/pip-bVSrpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:22 INFO - Running setup.py (path:/tmp/pip-esBSlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:22 INFO - Running setup.py (path:/tmp/pip-IcuVG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:22 INFO - Running setup.py (path:/tmp/pip-0MsNQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:22 INFO - Running setup.py (path:/tmp/pip-NjOfyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:22 INFO - Running setup.py (path:/tmp/pip-pjehJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:22 INFO - Running setup.py (path:/tmp/pip-PsHMv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:22 INFO - Running setup.py (path:/tmp/pip-D2Cw9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:23 INFO - Running setup.py (path:/tmp/pip-1TEnny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:23 INFO - Running setup.py (path:/tmp/pip-D85AtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:23 INFO - Running setup.py (path:/tmp/pip-v494B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:40:23 INFO - Running setup.py install for manifestparser 12:40:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:40:23 INFO - Running setup.py install for mozcrash 12:40:23 INFO - Running setup.py install for mozdebug 12:40:23 INFO - Running setup.py install for mozdevice 12:40:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:40:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:40:23 INFO - Running setup.py install for mozfile 12:40:23 INFO - Running setup.py install for mozhttpd 12:40:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:40:23 INFO - Running setup.py install for mozinfo 12:40:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:40:23 INFO - Running setup.py install for mozInstall 12:40:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Running setup.py install for mozleak 12:40:24 INFO - Running setup.py install for mozlog 12:40:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Running setup.py install for moznetwork 12:40:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Running setup.py install for mozprocess 12:40:24 INFO - Running setup.py install for mozprofile 12:40:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Running setup.py install for mozrunner 12:40:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:40:24 INFO - Running setup.py install for mozscreenshot 12:40:24 INFO - Running setup.py install for moztest 12:40:24 INFO - Running setup.py install for mozversion 12:40:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:40:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:40:25 INFO - Cleaning up... 12:40:25 INFO - Return code: 0 12:40:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:25 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')]} 12:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:25 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')]} 12:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:25 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 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:25 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 12:40:25 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 12:40:25 INFO - Using env: {'DISPLAY': ':0', 12:40:25 INFO - 'HOME': '/home/cltbld', 12:40:25 INFO - 'LANG': 'en_US.UTF-8', 12:40:25 INFO - 'LANGUAGE': 'en_US:en', 12:40:25 INFO - 'LOGNAME': 'cltbld', 12:40:25 INFO - 'MAIL': '/var/mail/cltbld', 12:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:25 INFO - 'MOZ_NO_REMOTE': '1', 12:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:25 INFO - 'NO_EM_RESTART': '1', 12:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:25 INFO - 'PWD': '/builds/slave/test', 12:40:25 INFO - 'SHELL': '/bin/bash', 12:40:25 INFO - 'SHLVL': '1', 12:40:25 INFO - 'TERM': 'linux', 12:40:25 INFO - 'TMOUT': '86400', 12:40:25 INFO - 'USER': 'cltbld', 12:40:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:25 INFO - '_': '/tools/buildbot/bin/python'} 12:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:25 INFO - Running setup.py (path:/tmp/pip-BJCSm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:25 INFO - Running setup.py (path:/tmp/pip-DDGBZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:25 INFO - Running setup.py (path:/tmp/pip-e89mxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:25 INFO - Running setup.py (path:/tmp/pip-xJ8qsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:25 INFO - Running setup.py (path:/tmp/pip-ZIjmsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:25 INFO - Running setup.py (path:/tmp/pip-DDtOQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:25 INFO - Running setup.py (path:/tmp/pip-5x_egu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:25 INFO - Running setup.py (path:/tmp/pip-YjQ_lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:25 INFO - Running setup.py (path:/tmp/pip-9pcYXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:25 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:25 INFO - Running setup.py (path:/tmp/pip-IoNzdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 12:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:25 INFO - Running setup.py (path:/tmp/pip-p1R_Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:26 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)) 12:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:26 INFO - Running setup.py (path:/tmp/pip-zDvnb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:26 INFO - Running setup.py (path:/tmp/pip-NRLaAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:26 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)) 12:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:26 INFO - Running setup.py (path:/tmp/pip-p1AV9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:26 INFO - Running setup.py (path:/tmp/pip-vP1Z84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:26 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)) 12:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:26 INFO - Running setup.py (path:/tmp/pip-M9QgTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:26 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)) 12:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:26 INFO - Running setup.py (path:/tmp/pip-fj5j6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:26 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)) 12:40:26 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)) 12:40:26 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)) 12:40:26 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)) 12:40:26 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)) 12:40:26 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)) 12:40:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:40:26 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 12:40:26 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 12:40:26 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 12:40:26 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 12:40:26 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 12:40:26 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 12:40:28 INFO - Downloading blessings-1.6.tar.gz 12:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:40:28 INFO - Installing collected packages: blessings 12:40:28 INFO - Running setup.py install for blessings 12:40:28 INFO - Successfully installed blessings 12:40:28 INFO - Cleaning up... 12:40:28 INFO - Return code: 0 12:40:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:40:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:28 INFO - Reading from file tmpfile_stdout 12:40:28 INFO - Current package versions: 12:40:28 INFO - argparse == 1.2.1 12:40:28 INFO - blessings == 1.6 12:40:28 INFO - blobuploader == 1.2.4 12:40:28 INFO - docopt == 0.6.1 12:40:28 INFO - functools32 == 3.2.3-2 12:40:28 INFO - jsonschema == 2.5.1 12:40:28 INFO - manifestparser == 1.1 12:40:28 INFO - mozInstall == 1.12 12:40:28 INFO - mozcrash == 0.17 12:40:28 INFO - mozdebug == 0.1 12:40:28 INFO - mozdevice == 0.48 12:40:28 INFO - mozfile == 1.2 12:40:28 INFO - mozhttpd == 0.7 12:40:28 INFO - mozinfo == 0.9 12:40:28 INFO - mozleak == 0.1 12:40:28 INFO - mozlog == 3.3 12:40:28 INFO - moznetwork == 0.27 12:40:28 INFO - mozprocess == 0.23 12:40:28 INFO - mozprofile == 0.28 12:40:28 INFO - mozrunner == 6.12 12:40:28 INFO - mozscreenshot == 0.1 12:40:28 INFO - mozsystemmonitor == 0.3 12:40:28 INFO - moztest == 0.7 12:40:28 INFO - mozversion == 1.4 12:40:28 INFO - psutil == 3.1.1 12:40:28 INFO - requests == 1.2.3 12:40:28 INFO - wsgiref == 0.1.2 12:40:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:28 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 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:28 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 12:40:28 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 12:40:28 INFO - Using env: {'DISPLAY': ':0', 12:40:28 INFO - 'HOME': '/home/cltbld', 12:40:28 INFO - 'LANG': 'en_US.UTF-8', 12:40:28 INFO - 'LANGUAGE': 'en_US:en', 12:40:28 INFO - 'LOGNAME': 'cltbld', 12:40:28 INFO - 'MAIL': '/var/mail/cltbld', 12:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:28 INFO - 'MOZ_NO_REMOTE': '1', 12:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:28 INFO - 'NO_EM_RESTART': '1', 12:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:28 INFO - 'PWD': '/builds/slave/test', 12:40:28 INFO - 'SHELL': '/bin/bash', 12:40:28 INFO - 'SHLVL': '1', 12:40:28 INFO - 'TERM': 'linux', 12:40:28 INFO - 'TMOUT': '86400', 12:40:28 INFO - 'USER': 'cltbld', 12:40:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:28 INFO - '_': '/tools/buildbot/bin/python'} 12:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 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)) 12:40:29 INFO - Cleaning up... 12:40:29 INFO - Return code: 0 12:40:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:29 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 0x2513030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, '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': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', '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 12:40:29 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 12:40:29 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 12:40:29 INFO - Using env: {'DISPLAY': ':0', 12:40:29 INFO - 'HOME': '/home/cltbld', 12:40:29 INFO - 'LANG': 'en_US.UTF-8', 12:40:29 INFO - 'LANGUAGE': 'en_US:en', 12:40:29 INFO - 'LOGNAME': 'cltbld', 12:40:29 INFO - 'MAIL': '/var/mail/cltbld', 12:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:29 INFO - 'MOZ_NO_REMOTE': '1', 12:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:29 INFO - 'NO_EM_RESTART': '1', 12:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:29 INFO - 'PWD': '/builds/slave/test', 12:40:29 INFO - 'SHELL': '/bin/bash', 12:40:29 INFO - 'SHLVL': '1', 12:40:29 INFO - 'TERM': 'linux', 12:40:29 INFO - 'TMOUT': '86400', 12:40:29 INFO - 'USER': 'cltbld', 12:40:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:29 INFO - '_': '/tools/buildbot/bin/python'} 12:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:40:29 INFO - Cleaning up... 12:40:29 INFO - Return code: 0 12:40:29 INFO - Running post-action listener: _resource_record_post_action 12:40:29 INFO - Running post-action listener: _start_resource_monitoring 12:40:29 INFO - Starting resource monitoring. 12:40:29 INFO - [mozharness: 2016-07-27 19:40:29.335000Z] Finished create-virtualenv step (success) 12:40:29 INFO - [mozharness: 2016-07-27 19:40:29.335477Z] Running install step. 12:40:29 INFO - Running pre-action listener: _resource_record_pre_action 12:40:29 INFO - Running main action method: install 12:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:29 INFO - Reading from file tmpfile_stdout 12:40:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:40:29 INFO - Reading from file tmpfile_stdout 12:40:29 INFO - Output received: 12:40:29 INFO - Usage: mozinstall [options] installer 12:40:29 INFO - Options: 12:40:29 INFO - -h, --help show this help message and exit 12:40:29 INFO - -d DEST, --destination=DEST 12:40:29 INFO - Directory to install application into. [default: 12:40:29 INFO - "/builds/slave/test"] 12:40:29 INFO - --app=APP Application being installed. [default: firefox] 12:40:29 INFO - mkdir: /builds/slave/test/build/application 12:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:40:50 INFO - Reading from file tmpfile_stdout 12:40:50 INFO - Output received: 12:40:50 INFO - /builds/slave/test/build/application/firefox/firefox 12:40:50 INFO - Running post-action listener: _resource_record_post_action 12:40:50 INFO - [mozharness: 2016-07-27 19:40:50.176777Z] Finished install step (success) 12:40:50 INFO - [mozharness: 2016-07-27 19:40:50.176900Z] Running run-tests step. 12:40:50 INFO - Running pre-action listener: _resource_record_pre_action 12:40:50 INFO - Running main action method: run_tests 12:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:50 INFO - Python 2.7.3 12:40:50 INFO - Return code: 0 12:40:50 INFO - grabbing minidump binary from tooltool 12:40: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')]} 12:40:50 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d1570>, '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 0x27d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40:50 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 12:40:50 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 12:40:50 INFO - Calling ['/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'] with output_timeout 600 12:40:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:50 INFO - Return code: 0 12:40:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:40:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:40:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:40:50 INFO - Using env: {'DISPLAY': ':0', 12:40:50 INFO - 'HOME': '/home/cltbld', 12:40:50 INFO - 'LANG': 'en_US.UTF-8', 12:40:50 INFO - 'LANGUAGE': 'en_US:en', 12:40:50 INFO - 'LOGNAME': 'cltbld', 12:40:50 INFO - 'MAIL': '/var/mail/cltbld', 12:40:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:50 INFO - 'MOZ_NO_REMOTE': '1', 12:40:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:50 INFO - 'NO_EM_RESTART': '1', 12:40:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:50 INFO - 'PWD': '/builds/slave/test', 12:40:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:50 INFO - 'SHELL': '/bin/bash', 12:40:50 INFO - 'SHLVL': '1', 12:40:50 INFO - 'TERM': 'linux', 12:40:50 INFO - 'TMOUT': '86400', 12:40:50 INFO - 'USER': 'cltbld', 12:40:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214', 12:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:50 INFO - '_': '/tools/buildbot/bin/python'} 12:40:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:40:53 INFO - mozversion application_buildid: 20160727112326 12:40:53 INFO - mozversion application_changeset: 3039b674a5a44844eb47f327ca7378d800eeb15d 12:40:53 INFO - mozversion application_display_name: Nightly 12:40:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:53 INFO - mozversion application_name: Firefox 12:40:53 INFO - mozversion application_remotingname: firefox 12:40:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:40:53 INFO - mozversion application_vendor: Mozilla 12:40:53 INFO - mozversion application_version: 50.0a1 12:40:53 INFO - mozversion platform_buildid: 20160727112326 12:40:53 INFO - mozversion platform_changeset: 3039b674a5a44844eb47f327ca7378d800eeb15d 12:40:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:40:53 INFO - mozversion platform_version: 50.0a1 12:40:53 INFO - using testdate: 1469648453 12:40:53 INFO - actual date: 1469648453 12:40:53 INFO - starting webserver on 'localhost:50027' 12:40:53 INFO - SUITE-START | Running 2 tests 12:40:53 INFO - TEST-START | dromaeo_css 12:40:53 INFO - operating with platform_type : linux_ 12:40:53 INFO - Initialising browser for dromaeo_css test... 12:40:53 INFO - TEST-INFO | started process 18056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDLuBfn/profile http://localhost:50027/getInfo.html) 12:41:01 INFO - PROCESS | 18056 | JavaScript error: , line 0: uncaught exception: undefined 12:41:03 INFO - PROCESS | 18056 | __metrics Screen width/height:1600/1200 12:41:03 INFO - PROCESS | 18056 | colorDepth:24 12:41:03 INFO - PROCESS | 18056 | Browser inner width/height: 1024/697 12:41:03 INFO - PROCESS | 18056 | __metrics 12:41:05 ERROR - PROCESS | 18056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:41:06 INFO - TEST-INFO | 18056: exit 0 12:41:06 INFO - Browser initialized. 12:41:06 INFO - Running cycle 1/1 for dromaeo_css test... 12:41:06 INFO - TEST-INFO | started process 18176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDLuBfn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:18 INFO - PROCESS | 18176 | RSS: Main: 165834752 12:41:18 INFO - PROCESS | 18176 | 12:42:07 INFO - PROCESS | 18176 | 1469648527978 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] 12:44:19 INFO - PROCESS | 18176 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50027/tests/dromaeo/cssquery-ext.html) 12:44:21 INFO - PROCESS | 18176 | RSS: Main: 170414080 12:44:21 INFO - PROCESS | 18176 | 12:47:23 INFO - PROCESS | 18176 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-ext.html (next: http://localhost:50027/tests/dromaeo/cssquery-jquery.html) 12:47:24 INFO - PROCESS | 18176 | RSS: Main: 170127360 12:47:24 INFO - PROCESS | 18176 | 12:50:26 INFO - PROCESS | 18176 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50027/tests/dromaeo/cssquery-mootools.html) 12:50:26 INFO - PROCESS | 18176 | RSS: Main: 173441024 12:50:26 INFO - PROCESS | 18176 | 12:53:28 INFO - PROCESS | 18176 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50027/tests/dromaeo/cssquery-prototype.html) 12:53:29 INFO - PROCESS | 18176 | RSS: Main: 167493632 12:53:29 INFO - PROCESS | 18176 | 12:56:31 INFO - PROCESS | 18176 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50027/tests/dromaeo/cssquery-yui.html) 12:56:32 INFO - PROCESS | 18176 | RSS: Main: 169832448 12:56:32 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-yui.html (next: http://localhost:50027/tests/dromaeo/cssquery-dojo.html) 12:59:35 INFO - PROCESS | 18176 | RSS: Main: 173080576 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | __start_tp_report 12:59:35 INFO - PROCESS | 18176 | _x_x_mozilla_page_load 12:59:35 INFO - PROCESS | 18176 | _x_x_mozilla_page_load_details 12:59:35 INFO - PROCESS | 18176 | |i|pagename|runs| 12:59:35 INFO - PROCESS | 18176 | |0;dojo.html;2623.8688065596716;2628.9746998670516;2653.204038788363;2655.933601659958;2663.560512515436;4640.489546149929;4720.4571474280465;4721.197396442604;4748.857534273969;4753.453352864417;4763.809447622091;4792.424909010923;4800.5679488846;4841.128596852565;4851.587615052725;4231.466463123754;4358.65130789536;4510.661700372469;4513.819447222108;4514.796834142455;4475.955240447603;4483.34991426243;4484.551544845522;4487.506374298824;4526.569975852289;4282.528921818597;4361;4413.139437809628;4470.418845550058;4471.374007638933;4340.65274778017;4342.457192850894;4344.4352234209355;4436.778161091965;4471.016376397188;4345.044090300129;4358.869233922987;4359.17175736609;4362.454693163355;4389.253826849412;4708.105459962596;4722.645801564862;4722.976385118087;4781.187198176319;4817.735024573647;5114.590832733373;5120.61595380348;5122.769475373617;5132.153194722866;5182.922256166161;5171.965606878639;5176.7929282828645;5180.766865491024;5200.29795977542;5212.166053431432;4675.368825208588;4711.081339138869;4733.053389322149;4764.785584648699;4780.091782561302;5167.586593072545;5176.19768935808;5185.974070129625;5187.3399467939935;5192.402873669501;4985.601151907911;4988.301637770715;4992.850214493571;4993.0762808879745;4995.25071239317;4972.403311602631;5107.565856902131;5129.743512824344;5135.922961155586;5178.585713143015;5107.7446127693465;5110.693358398508;5117.488251174853;5132.794688212504;5142.820001299937;5119.436861945183;5126.5898728101665;5138.871528211825;5146.125158723026;5175.223716442564;4247.5752424757275;4322.243607368698;4354.804033818423;4357.150355680612;4386.320120381346;3761.8495260189284;3763.6989040876665;3774.8490060397826;3807.6573108420375;3812.599677033927;4375.759333236702;4396.824127034883;4416.668749843775;4426;4445.355423463644;4967.428745694219;5033.672811267256;5098.617603679665;5105.387353517602;5194.1429664105;4398.115806071781;4409.382686423904;4417.050334178167;4424.004598965207;4449.57729015743;4621;4630.907381852411;4646.117237724821;4653.534646535387;4700.412448443944;4661.86014419568;4729.3851799265185;4764.118638051971;4778.641601879943;4787.61699064067;5064.5948324134715;5064.873378165576;5082.720450375265;5082.974585127198;5128.102582048201;4721.409823772028;4745.9050818984115;4765.070811191785;4804.975975120102;4812.975935120302;4912.484189160086;4979.103761322852;4982.950170498394;5011.574016208518;5074.3657042869645;5160.48395160481;5169.457206993212;5175.715335656575;5191.532762051434;5256.868578285574;4988.975055124701;5040.823571174991;5050.065737838511;5052;5098.439171691185;4866.902661946812;4938.259261110862;4943.110240156806;5034.244863270539;5049;4832.130216561053;4904.460509343898;4907.3620429343955;4917.311576379381;4934.136526107845;5035.420926593342;5064.772085256099;5071.442141364373;5107.744612769272;5133.79464821403;4873.488283730299;4876.731779752005;4919.819243381634;4930.802767889388;4982.352294201731 12:59:35 INFO - PROCESS | 18176 | |1;ext.html;545.3101826189869;550.8375029366337;593.623049363654;599.7840777320162;601.9548533859959;32107.678923210762;35203.82398088009;35223.99999999997;35253.82373088138;35266.64733352666;35134.64865351345;35896.282074358496;35903.46144807823;36036.2792744145;36072.63927360726;7338.229485903983;7571.24287571244;7594.316511513963;7616.314531692146;7651.732189373373;7457.589832559207;7578.317951384374;7609.809754756147;7659.310662040415;7662.885056724153;7671.347935425496;7723.22767723226;7725.884111738328;7726.0342457192855;7745.6127193640095;7638.770836874903;7649.655765490566;7682.078150621961;7683.346915512188;7697.4226932980255;7480.102387713455;7599.088109426849;7599.506032107895;7625.389968802482;7632.885506717348;33502;33672.6632733672;33951.32097358039;34034.82982585096;34039;2665.375089877765;2877.6259086318855;2900.10096869971;3083.398737246238;3191.4734068878606;27365.45269094607;27720;27811.86094069537;27816.582751258746;27875.16374508768;3333.3666603345287;3344;3406.114410253327;3544.663256990582;3546.219831637036;214615;214913;215189;215806.92096539575;216585;30663.8466807669;31471.685283146875;31672.524912126337;46047.309290360674;46798.76600616975;32590.185245369055;32914.3417131656;33008.83495582555;33023.174420639196;33116;12578.874211257771;12630.115891887663;12711.110222284537;12740.299283539309;12775.297358645365;10413.219008574388;10433.373997560171;10481.423521706227;10525.578976840994;10543.683689489328;7757.301842834172;7792.181820908723;7813.140554538996;7837.05955285358;7867.331276841533;3056.1595561220843;3066.647335556395;3096.2723759916403;3127.1712996056062;3137.1216059503377;869.9782505437415;891.741394995457;927.4713413354458;965.792354643741;979.9853002204973;28038;28237.43525129486;28427.857860710978;28701.85649071741;28959.85520072386;829.8589239829244;956.063058202965;970.5632465390603;979.1628157924872;1018.9796204076025;13135.277559734306;13842.307884605729;14107.36516856744;14155.221462819438;14262.786058209134;418780;422156;424289;424661;425471;48360.5163948356;48591;48771;48803.75598121987;49146;1141.680329507739;1184.3012622552562;1195.802692555736;1203.8555373355252;1210.5460452330376;25310;25923.22230333093;26927.86536067307;27585.172444826687;27632.585511216945;39382.2123557533;39722;39772;39838.80080599579;39844.40233396443;276959;277462;348724;348872;348979;24446.87776561177;24722.629160562246;24828.875855620605;24839;24919.75080249247;40476.80823886368;40742.79628601957;41100.1779964405;41205.793971029954;41605.37591936184;34131.14672133217;35477.64522354847;36023;39008.41487377748;41122;28970.565441518815;29056.418871622027;29587.704122959356;29675.40649186961;30067.248318792204;35570.46644300286;35950;36363.45454818127;36625;39307;29994.400111998075;32240.83879580587;33431;33817;33863.49204761881;25269.24192274235;25843.741562584135;25845.48309033771;25852.35369115712;25940.61089083703 12:59:35 INFO - PROCESS | 18176 | |2;jquery.html;355.63369729178936;364.275092565794;370.9035650730809;379.6734808065065;386.14468951272926;15911.920440397796;16527.25627346771;17344.132793360328;17503.299868005266;17568.29726810926;16164.434244801434;16184.75722864158;16510.422135225268;16521.173941302946;16940.66118677626;5034.395872495296;5231.607629427789;5254.947450525484;5267.3679158500845;5286.577073834103;5145.794168233266;5225.6864588124645;5225.895482090375;5264.947350526503;5281;5442.047641662713;5554.750036248379;5584.022796010702;5588.776448942058;5589.524890384302;5555.527780138673;5572;5580.107182850745;5854.18041474194;6053.636781793062;5325.908188821282;5361.919571206435;5366.087765079946;5377.220303056035;5381.730913454312;19966.80033199664;20489.795102049087;20940.58118837615;21102.683459748117;21142;1825.187791432813;1898.9240430382767;1916.7508223930938;1997.2011195521761;2402.4354276745125;8975.640974361018;9010.909890901072;9037.277017838556;9630.422174669473;9683.515824208831;1712.297957837293;1763.867709921761;1800.5138612574663;1836.8622353323553;1847.8521718262507;71922;72179.63910180469;72189.63905180493;73839.63080184565;75701;9481.288903332277;9596.424214547149;9756.707298781048;10069.899301007043;10291.382517049002;13636.113652612747;13662.18026918388;13692.110012849133;13712;13717.108387954951;6736.494762892705;6750.831229219309;6936.445084393236;7030.859382812315;7037.824054398681;6334.493240540838;6387.872242555123;6525.967370163119;6537.607743535403;6540.901886471706;4149.460570125864;4269.466316710411;4324.243257429937;4361.454818147731;4396.626286765597;1795.353672677835;1797.191263931236;1800.2798880447663;1832.4136276391428;1847.0949234875084;843.20317300152;843.3885433060982;854.1501206299647;883.6730409748305;943.9764005899907;17107.657846842994;17159.485215443558;17873;18145.274189032556;18234.544136396697;834.2283387866321;836.272442974616;845.4927043773687;848.6817443458702;854.2909385210261;8358.498490090493;9621.374610650286;9901.950490247647;10191.286609937382;10231.641892533726;376882;386818;387066;389642;392143;75143.62428187823;75393.62303188558;76860.61569692116;77043.0661240491;80205.59897200477;885.4996926736374;898.9685361012333;913.1735779119907;915.9267258619294;917.2066162769156;15293.235338232822;15537.766933496232;15981.8401815985;16287.348506059625;16312.836871631607;37508.81245593754;38134.42798358083;38176.61823381731;38500.22999539937;39042.41436378514;52323.73838130937;52887.73556132195;53079.203811942076;54380.45619543754;55276.447235528736;6050.213472248755;7154.67803948834;7186.640667966476;7357.668904899399;7553.433492488195;11601.767964640829;11813;12118.878811212127;12355.382230888239;12365.690857728629;5178.922316165336;9684.32209745311;10211.285210035227;10246.436445995541;10717.785644286914;10169.694909152737;10173.949130254301;10244.59021639156;10280.948595256976;10492.580296788043;9818.901810981799;10021.849672254777;10056.296059276074;10074.69775906724;10319.638812641522;7157.176924653523;7367.2264412235945;7429.665665045194;7455.589942553212;7618.542887426772;8136.430449868452;9979.501024948579;10229.437380943822;10396.272260941661;10593.52329145175 12:59:35 INFO - PROCESS | 18176 | |3;mootools.html;1387.4519564771913;1416.1573863551187;1456.1990905002247;1606.975895361569;1648.6372997940457;6751.628660423675;7301;7422.480426370156;7799.844003119934;7807.984961954945;7556.848863022737;7840.490368126082;7853.410994175431;7855.135935047155;7856.685732570704;2125.511132439544;2147.194801949261;2161.167950339123;2162.50262439639;2164.9891750541224;2109.493721506835;2145.9356219313445;2175.815055720258;2186.9453263668374;2192.7478339990867;2153.752318483371;2154.8491605587615;2166.599179151854;2176.325339144862;2181.8690878547336;2120.720225757317;2131.7761635028255;2140.7003019577273;2146.1737231165957;2146.3024517032027;2041.5100375909824;2101.81083702466;2107.5679485705396;2133.232036466871;2135.7010018597407;7848.2151784821635;7878.921210787876;7895.447318687694;7896.328812050982;7896.842063158705;4349.2388831954595;4492.415985921842;4493.460784705823;4497.775111244425;4505.954940450586;2704.6754389473194;2711.30861630283;2752.7474998875464;2790.3582176099612;2792.5252707039854;903.5482258870564;945.7068308824287;946.4983558713893;957.4111921168501;969.7042402067367;10442.164626829912;10455.477226138739;10465.1627869771;10512.947435262851;10516.211284153718;3953.743006704555;4067.1052368478886;4160.438340824011;4224.514180869178;4231.2383770920915;8946.642134314685;9049.321300902327;9057.728268151966;9079.092090790868;9086.54567271647;4416.558344165622;4466.218411777926;4467.374567560544;4483.14820184164;4486.035502367007;3500.2299494111253;3804.752691075071;3876.903077423087;4024.4969378827645;4039;3556.928861422757;3565.3047655707405;3687.3178461984617;3712.9443058354145;3767.6232376762105;1156.5258244120039;1171.800793865045;1172.372780562395;1173.1318824070127;1181.6927598824368;744.140517702055;746.7796999885047;798.7060961242707;799.5043073294595;833.954132522717;5131.948680513147;5135.563477104413;5163.845084647466;5329.626926115135;5377.193420986883;392.22731219497547;392.2703770985964;393.5788706084462;395.83572817280503;400.21557746816563;3660.816959152085;3747.550293964687;3747.6439738224826;3763.1532905096683;3784.6972242220554;9335.346525743133;9622;9734;9745.025497450199;9747.415155090717;9639.807203855884;9647.469389183521;9671.516424178762;9671.854922176173;9680.661176858775;7378.5941773202985;7415.1101867776215;7506.061742282215;7519.210482899326;7525;5025.070361983045;5048.444671086251;5067.41724701664;5169.4830516948;5231.3199284092825;8789.472631642122;8848.690295839615;8921.598528066123;8995.505247211204;9014.504202268938;8773.605187766438;9030.63877444895;9149.5882685278;9192.954035230048;9206.9539652304;5810.070388737781;6141.9078713818435;6325.715342809676;6381.425671689571;6500.869982600227;7334.96332518334;7369.852602948018;7394.7781566553085;7396.815079623052;7400.48196626231;6086.482648974887;6300.779472718433;6351.841203969938;6380.819548383564;6475.902861457176;6210.4100110489435;6267.059941008885;6272.498200143887;6292.685365731787;6332.271788744353;5940.495057919952;6049.939500604937;6056.636601803906;6064.151018857452;6079.969600151971;4595.563421474954;4613.446386433515;4617.6536759742485;4638.049199913942;4685.1332503486965;4526.615237704832;4536.5236650151255;4632.328312394751;4714.151452738402;4744.288356746378 12:59:35 INFO - PROCESS | 18176 | |4;prototype.html;296.5225986162279;304.368435496345;308.4309449066473;310.81661819526477;311.4502902377304;5143.434222235555;5156.550638446736;5170.276161337416;5184.818531351403;5195.766190521426;5057.595392368611;5061.19020956647;5077.679803251153;5084.034033533635;5105.923411148827;3714.090047938252;3791.4312853072124;3862.5515431713106;3920.882373528799;3933;3873.6513713765758;3910.667593254577;3911.8044097794996;3913.3738601823716;3935.803209839511;3860.4209368594657;3902.414637804324;3915.490986171794;3916.0992971616547;3927.6857851371824;3790.5451345838674;3862.343401621703;3894.201688653819;3935.291647503448;3941.1132495188494;3410.18155642644;3416.572928383952;3418.8461519231696;3428.502867084284;3429;4935.481774413671;4951.851444456672;4974.10466116099;4976.681179487438;4976.825811096631;4397.450318710161;4468.19572476954;4496.842610508649;4500.459944806611;4510.075434535912;5253.763580638881;5257.842264732064;5291.788328466857;5306.850725456196;5309.548688361494;3749.2876353492748;3749.4938183345444;3750.4374343848367;3759.8496060157563;3763.153290509641;5379.408265090798;5531.3915469298345;5572.219889215513;5589.301337332833;5594.860128496779;3800;3842.731008829411;3867.284552357823;3874.49631547897;3881.340172170738;3884.7863367515056;3920.157166209279;3922.705507182623;3925.784081875467;3929.685625149981;4441.578050085237;4463.531329210451;4497.235469970113;4506.774661266923;4508.752018638941;5154.92267615986;5239.397469291081;5253.947460525423;5312.415634280226;5344.198370244417;1326.9402876870563;1347.8113064171023;1350.2033800058014;1351.2433037499031;1352.959411217665;855.2003876375609;880.6873559886149;891.585412783046;894.2845723421367;901.6979311930446;4401.22978478765;4474.597286244254;4630.421197350332;4664.55686709762;4668.719876807402;5456.863578410492;5482.5613950883835;5528.75120619573;5532.8186292881755;5564.190084007631;4634.330884256187;4705;4705.858824235278;4724.102420540086;4739.1706451371565;2849.28767808048;2904.4626744051993;2919.3431477917297;2932.4868148074;2938.397628486155;5105.285260063594;5145.4597267287145;5169.767360468788;5183.50756678115;5205.73971301441;5303.602229832778;5591.664500130005;5612.867110497985;5658.575606829504;5678.659280443187;5084.41529224144;5103.260027296095;5127.743612819419;5140.126178549581;5141.434442211354;5549.889002219852;5554.2779438672715;5580.386157522588;5596.384397716167;5610.186522954067;5238.659487133325;5397.190421436816;5405.162199859028;5413.621046526863;5422.349318081698;5134.45966210128;5160.819371321985;5187.29971453864;5190.40310364313;5203.973980130075;3797.4873392091713;3819.217060502646;3819.331616967075;3827.3876179811095;3832.1186127190344;5381.946180538144;5449.836504904859;5488.396276409512;5547.223388725501;5593.622710348167;5305.70818604965;5323.920141197807;5366.6779993200535;5411.810586629449;5429.484199001088;5340.75966581497;5369.624126311121;5397.487238712316;5402.51377376038;5436.266104075899;5030.698158110525;5273.367195936512;5273.604479664117;5295.364556253275;5298.28473156119;5165.535101840853;5285.365756109291;5386.084365657769;5401.837944861661;5442;5180.507851754077;5220.425753167073;5222.843314700565;5224.164133738584;5226.63413561047 12:59:35 INFO - PROCESS | 18176 | |5;yui.html;577.2553406106126;606.193762296146;682.9590224586522;711.2629884966127;712.9626393597316;11363.147763917697;11962.461689223985;11973.461194246258;13335.199888006702;13999.230042347692;14337.283135843192;14365;14395.568132956001;14483.5654930352;14493.63765905853;776.3323541754102;796.6096612659784;797.7088362747613;797.9162187970267;800.6237068577789;632.1118828046602;760.0423466432308;780.3445106110865;787.0791174326024;790.5414859381544;822.2476434062826;823.3125340340822;824.9340052795792;825.8430898129366;827.7227128911821;814.5194335342118;819.8606236939705;821.0393839208141;821.3183058061854;823.4853216739538;601.5217901768104;601.8405122642504;602.1509671363357;602.5300265792645;605.1255935173676;12046.638600841989;12100.213486123463;12133.272003679807;12135.514579416813;12139.028877689763;12548.874511254862;12596.874031259662;12600.306983115925;12727.172733772275;12746.617601471879;9848.359856609297;9863.792845382413;9935.950320248425;10059.144972677332;10123.240756943258;3233.7898036627544;3258.771885967983;3261.1194977356217;3305.50552741819;3314.3537010283003;64510.3548964509;65705.3429465704;66317.99999999952;66784.3321566783;68393;9390.765230869147;9526.428414295164;9603.327767056378;9699.369540979813;9728.027197280357;17418.91290543539;17470.825291746918;17687.557811054827;17716.468505944842;18460.907695461436;6273.1844860167885;6485.4811615070685;6504.154459920274;6571.67141642916;6583.769568065095;3568.232829941575;3598.190407158421;3789.829457674411;3862.439946207784;3891.338472459632;2713.796465265113;2808.69104398516;2819.901303454369;2824.6045553622507;2826.632537770118;493.52374958164825;503.4260942525524;506.2987761949726;516.5273774496294;518.6913786297147;467.31071669288207;523.3876364653364;524.3943245551394;537.8494021673938;573.7217449536971;7647.273509016634;7829.491083079582;7852.214778522216;8270.545120018456;8562.571871406404;517.2809794385806;529.8728305206722;555.5916401444935;582.2198254339206;590.8995470769979;3641.453781932731;3768.7550309229814;3794.0894185395305;3887.5723670396233;4010.6590939769862;95520.52239738757;97227.51386243165;98453.50773246231;101185.8932696061;101473.49263253636;84201.57899210465;85700.57149714336;85924;86337.56831215929;87738;73560.05759769656;75091.24908750952;79193;79301.60349198332;79747;7278.417726581755;7328.267173282629;7406.962965185139;7550.207228240955;7733.8839917400155;46513.069738605715;46845.53154468412;46875;46919;46920;56561.717191415424;63457.682711586145;67998.32001680118;68113.31886681268;69894.65052674703;9444.622215111318;9564;9573.425594464354;9595.42427454355;9690.806183876142;10632;10647.574097036031;10664.200184986003;10762.838557421488;10836.078933290759;9803.313768036169;9862.161716254199;10004.449755263531;10025.949870250603;10036.698899033041;9557.426554406758;9732.756681082747;9741.220702343653;9753;9816.852747208655;9982.900170998197;10027.147692445931;10077.445740484343;10100.242481813746;10595.046445819913;8190.631421586162;8313.584320783815;8518.105598912272;8661.91338086611;8667.479951202948;8399.832003360021;8634.438761480735;8660.40406640088;8710.303175746052;8926.86609700868 12:59:35 INFO - PROCESS | 18176 | __end_tp_report 12:59:35 INFO - PROCESS | 18176 | __start_cc_report 12:59:35 INFO - PROCESS | 18176 | _x_x_mozilla_cycle_collect,381 12:59:35 INFO - PROCESS | 18176 | __end_cc_report 12:59:35 INFO - PROCESS | 18176 | __startTimestamp1469649575370__endTimestamp 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | ------- Summary: start ------- 12:59:35 INFO - PROCESS | 18176 | Number of tests: 6 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | [#0] dojo.html Cycles:165 Average:4726.04 Median:4817.74 stddev:498.95 (10.4%) stddev-sans-first:472.45 12:59:35 INFO - PROCESS | 18176 | Values: 2623.9 2629.0 2653.2 2655.9 2663.6 4640.5 4720.5 4721.2 4748.9 4753.5 4763.8 4792.4 4800.6 4841.1 4851.6 4231.5 4358.7 4510.7 4513.8 4514.8 4476.0 4483.3 4484.6 4487.5 4526.6 4282.5 4361.0 4413.1 4470.4 4471.4 4340.7 4342.5 4344.4 4436.8 4471.0 4345.0 4358.9 4359.2 4362.5 4389.3 4708.1 4722.6 4723.0 4781.2 4817.7 5114.6 5120.6 5122.8 5132.2 5182.9 5172.0 5176.8 5180.8 5200.3 5212.2 4675.4 4711.1 4733.1 4764.8 4780.1 5167.6 5176.2 5186.0 5187.3 5192.4 4985.6 4988.3 4992.9 4993.1 4995.3 4972.4 5107.6 5129.7 5135.9 5178.6 5107.7 5110.7 5117.5 5132.8 5142.8 5119.4 5126.6 5138.9 5146.1 5175.2 4247.6 4322.2 4354.8 4357.2 4386.3 3761.8 3763.7 3774.8 3807.7 3812.6 4375.8 4396.8 4416.7 4426.0 4445.4 4967.4 5033.7 5098.6 5105.4 5194.1 4398.1 4409.4 4417.1 4424.0 4449.6 4621.0 4630.9 4646.1 4653.5 4700.4 4661.9 4729.4 4764.1 4778.6 4787.6 5064.6 5064.9 5082.7 5083.0 5128.1 4721.4 4745.9 4765.1 4805.0 4813.0 4912.5 4979.1 4983.0 5011.6 5074.4 5160.5 5169.5 5175.7 5191.5 5256.9 4989.0 5040.8 5050.1 5052.0 5098.4 4866.9 4938.3 4943.1 5034.2 5049.0 4832.1 4904.5 4907.4 4917.3 4934.1 5035.4 5064.8 5071.4 5107.7 5133.8 4873.5 4876.7 4919.8 4930.8 4982.4 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | [#1] ext.html Cycles:180 Average:45228.72 Median:191427.57 stddev:87868.92 (45.9%) stddev-sans-first:88051.37 12:59:35 INFO - PROCESS | 18176 | Values: 545.3 550.8 593.6 599.8 602.0 32107.7 35203.8 35224.0 35253.8 35266.6 35134.6 35896.3 35903.5 36036.3 36072.6 7338.2 7571.2 7594.3 7616.3 7651.7 7457.6 7578.3 7609.8 7659.3 7662.9 7671.3 7723.2 7725.9 7726.0 7745.6 7638.8 7649.7 7682.1 7683.3 7697.4 7480.1 7599.1 7599.5 7625.4 7632.9 33502.0 33672.7 33951.3 34034.8 34039.0 2665.4 2877.6 2900.1 3083.4 3191.5 27365.5 27720.0 27811.9 27816.6 27875.2 3333.4 3344.0 3406.1 3544.7 3546.2 214615.0 214913.0 215189.0 215806.9 216585.0 30663.8 31471.7 31672.5 46047.3 46798.8 32590.2 32914.3 33008.8 33023.2 33116.0 12578.9 12630.1 12711.1 12740.3 12775.3 10413.2 10433.4 10481.4 10525.6 10543.7 7757.3 7792.2 7813.1 7837.1 7867.3 3056.2 3066.6 3096.3 3127.2 3137.1 870.0 891.7 927.5 965.8 980.0 28038.0 28237.4 28427.9 28701.9 28959.9 829.9 956.1 970.6 979.2 1019.0 13135.3 13842.3 14107.4 14155.2 14262.8 418780.0 422156.0 424289.0 424661.0 425471.0 48360.5 48591.0 48771.0 48803.8 49146.0 1141.7 1184.3 1195.8 1203.9 1210.5 25310.0 25923.2 26927.9 27585.2 27632.6 39382.2 39722.0 39772.0 39838.8 39844.4 276959.0 277462.0 348724.0 348872.0 348979.0 24446.9 24722.6 24828.9 24839.0 24919.8 40476.8 40742.8 41100.2 41205.8 41605.4 34131.1 35477.6 36023.0 39008.4 41122.0 28970.6 29056.4 29587.7 29675.4 30067.2 35570.5 35950.0 36363.5 36625.0 39307.0 29994.4 32240.8 33431.0 33817.0 33863.5 25269.2 25843.7 25845.5 25852.4 25940.6 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | [#2] jquery.html Cycles:180 Average:24387.42 Median:5162.36 stddev:63981.59 (1239.4%) stddev-sans-first:64135.63 12:59:35 INFO - PROCESS | 18176 | Values: 355.6 364.3 370.9 379.7 386.1 15911.9 16527.3 17344.1 17503.3 17568.3 16164.4 16184.8 16510.4 16521.2 16940.7 5034.4 5231.6 5254.9 5267.4 5286.6 5145.8 5225.7 5225.9 5264.9 5281.0 5442.0 5554.8 5584.0 5588.8 5589.5 5555.5 5572.0 5580.1 5854.2 6053.6 5325.9 5361.9 5366.1 5377.2 5381.7 19966.8 20489.8 20940.6 21102.7 21142.0 1825.2 1898.9 1916.8 1997.2 2402.4 8975.6 9010.9 9037.3 9630.4 9683.5 1712.3 1763.9 1800.5 1836.9 1847.9 71922.0 72179.6 72189.6 73839.6 75701.0 9481.3 9596.4 9756.7 10069.9 10291.4 13636.1 13662.2 13692.1 13712.0 13717.1 6736.5 6750.8 6936.4 7030.9 7037.8 6334.5 6387.9 6526.0 6537.6 6540.9 4149.5 4269.5 4324.2 4361.5 4396.6 1795.4 1797.2 1800.3 1832.4 1847.1 843.2 843.4 854.2 883.7 944.0 17107.7 17159.5 17873.0 18145.3 18234.5 834.2 836.3 845.5 848.7 854.3 8358.5 9621.4 9902.0 10191.3 10231.6 376882.0 386818.0 387066.0 389642.0 392143.0 75143.6 75393.6 76860.6 77043.1 80205.6 885.5 899.0 913.2 915.9 917.2 15293.2 15537.8 15981.8 16287.3 16312.8 37508.8 38134.4 38176.6 38500.2 39042.4 52323.7 52887.7 53079.2 54380.5 55276.4 6050.2 7154.7 7186.6 7357.7 7553.4 11601.8 11813.0 12118.9 12355.4 12365.7 5178.9 9684.3 10211.3 10246.4 10717.8 10169.7 10173.9 10244.6 10280.9 10492.6 9818.9 10021.8 10056.3 10074.7 10319.6 7157.2 7367.2 7429.7 7455.6 7618.5 8136.4 9979.5 10229.4 10396.3 10593.5 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | [#3] mootools.html Cycles:180 Average:5049.59 Median:5036.76 stddev:2875.51 (57.1%) stddev-sans-first:2870.41 12:59:35 INFO - PROCESS | 18176 | Values: 1387.5 1416.2 1456.2 1607.0 1648.6 6751.6 7301.0 7422.5 7799.8 7808.0 7556.8 7840.5 7853.4 7855.1 7856.7 2125.5 2147.2 2161.2 2162.5 2165.0 2109.5 2145.9 2175.8 2186.9 2192.7 2153.8 2154.8 2166.6 2176.3 2181.9 2120.7 2131.8 2140.7 2146.2 2146.3 2041.5 2101.8 2107.6 2133.2 2135.7 7848.2 7878.9 7895.4 7896.3 7896.8 4349.2 4492.4 4493.5 4497.8 4506.0 2704.7 2711.3 2752.7 2790.4 2792.5 903.5 945.7 946.5 957.4 969.7 10442.2 10455.5 10465.2 10512.9 10516.2 3953.7 4067.1 4160.4 4224.5 4231.2 8946.6 9049.3 9057.7 9079.1 9086.5 4416.6 4466.2 4467.4 4483.1 4486.0 3500.2 3804.8 3876.9 4024.5 4039.0 3556.9 3565.3 3687.3 3712.9 3767.6 1156.5 1171.8 1172.4 1173.1 1181.7 744.1 746.8 798.7 799.5 834.0 5131.9 5135.6 5163.8 5329.6 5377.2 392.2 392.3 393.6 395.8 400.2 3660.8 3747.6 3747.6 3763.2 3784.7 9335.3 9622.0 9734.0 9745.0 9747.4 9639.8 9647.5 9671.5 9671.9 9680.7 7378.6 7415.1 7506.1 7519.2 7525.0 5025.1 5048.4 5067.4 5169.5 5231.3 8789.5 8848.7 8921.6 8995.5 9014.5 8773.6 9030.6 9149.6 9193.0 9207.0 5810.1 6141.9 6325.7 6381.4 6500.9 7335.0 7369.9 7394.8 7396.8 7400.5 6086.5 6300.8 6351.8 6380.8 6475.9 6210.4 6267.1 6272.5 6292.7 6332.3 5940.5 6049.9 6056.6 6064.2 6080.0 4595.6 4613.4 4617.7 4638.0 4685.1 4526.6 4536.5 4632.3 4714.2 4744.3 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | [#4] prototype.html Cycles:180 Average:4410.99 Median:5093.84 stddev:1298.53 (25.5%) stddev-sans-first:1264.92 12:59:35 INFO - PROCESS | 18176 | Values: 296.5 304.4 308.4 310.8 311.5 5143.4 5156.6 5170.3 5184.8 5195.8 5057.6 5061.2 5077.7 5084.0 5105.9 3714.1 3791.4 3862.6 3920.9 3933.0 3873.7 3910.7 3911.8 3913.4 3935.8 3860.4 3902.4 3915.5 3916.1 3927.7 3790.5 3862.3 3894.2 3935.3 3941.1 3410.2 3416.6 3418.8 3428.5 3429.0 4935.5 4951.9 4974.1 4976.7 4976.8 4397.5 4468.2 4496.8 4500.5 4510.1 5253.8 5257.8 5291.8 5306.9 5309.5 3749.3 3749.5 3750.4 3759.8 3763.2 5379.4 5531.4 5572.2 5589.3 5594.9 3800.0 3842.7 3867.3 3874.5 3881.3 3884.8 3920.2 3922.7 3925.8 3929.7 4441.6 4463.5 4497.2 4506.8 4508.8 5154.9 5239.4 5253.9 5312.4 5344.2 1326.9 1347.8 1350.2 1351.2 1353.0 855.2 880.7 891.6 894.3 901.7 4401.2 4474.6 4630.4 4664.6 4668.7 5456.9 5482.6 5528.8 5532.8 5564.2 4634.3 4705.0 4705.9 4724.1 4739.2 2849.3 2904.5 2919.3 2932.5 2938.4 5105.3 5145.5 5169.8 5183.5 5205.7 5303.6 5591.7 5612.9 5658.6 5678.7 5084.4 5103.3 5127.7 5140.1 5141.4 5549.9 5554.3 5580.4 5596.4 5610.2 5238.7 5397.2 5405.2 5413.6 5422.3 5134.5 5160.8 5187.3 5190.4 5204.0 3797.5 3819.2 3819.3 3827.4 3832.1 5381.9 5449.8 5488.4 5547.2 5593.6 5305.7 5323.9 5366.7 5411.8 5429.5 5340.8 5369.6 5397.5 5402.5 5436.3 5030.7 5273.4 5273.6 5295.4 5298.3 5165.5 5285.4 5386.1 5401.8 5442.0 5180.5 5220.4 5222.8 5224.2 5226.6 12:59:35 INFO - PROCESS | 18176 | 12:59:35 INFO - PROCESS | 18176 | [#5] yui.html Cycles:180 Average:17732.99 Median:32044.90 stddev:26288.24 (82.0%) stddev-sans-first:26330.42 12:59:35 INFO - PROCESS | 18176 | Values: 577.3 606.2 683.0 711.3 713.0 11363.1 11962.5 11973.5 13335.2 13999.2 14337.3 14365.0 14395.6 14483.6 14493.6 776.3 796.6 797.7 797.9 800.6 632.1 760.0 780.3 787.1 790.5 822.2 823.3 824.9 825.8 827.7 814.5 819.9 821.0 821.3 823.5 601.5 601.8 602.2 602.5 605.1 12046.6 12100.2 12133.3 12135.5 12139.0 12548.9 12596.9 12600.3 12727.2 12746.6 9848.4 9863.8 9936.0 10059.1 10123.2 3233.8 3258.8 3261.1 3305.5 3314.4 64510.4 65705.3 66318.0 66784.3 68393.0 9390.8 9526.4 9603.3 9699.4 9728.0 17418.9 17470.8 17687.6 17716.5 18460.9 6273.2 6485.5 6504.2 6571.7 6583.8 3568.2 3598.2 3789.8 3862.4 3891.3 2713.8 2808.7 2819.9 2824.6 2826.6 493.5 503.4 506.3 516.5 518.7 467.3 523.4 524.4 537.8 573.7 7647.3 7829.5 7852.2 8270.5 8562.6 517.3 529.9 555.6 582.2 590.9 3641.5 3768.8 3794.1 3887.6 4010.7 95520.5 97227.5 98453.5 101185.9 101473.5 84201.6 85700.6 85924.0 86337.6 87738.0 73560.1 75091.2 79193.0 79301.6 79747.0 7278.4 7328.3 7407.0 7550.2 7733.9 46513.1 46845.5 46875.0 46919.0 46920.0 56561.7 63457.7 67998.3 68113.3 69894.7 9444.6 9564.0 9573.4 9595.4 9690.8 10632.0 10647.6 10664.2 10762.8 10836.1 9803.3 9862.2 10004.4 10025.9 10036.7 9557.4 9732.8 9741.2 9753.0 9816.9 9982.9 10027.1 10077.4 10100.2 10595.0 8190.6 8313.6 8518.1 8661.9 8667.5 8399.8 8634.4 8660.4 8710.3 8926.9 12:59:35 INFO - PROCESS | 18176 | -------- Summary: end -------- 12:59:35 INFO - PROCESS | 18176 | 12:59:36 INFO - TEST-INFO | 18176: exit 0 12:59:36 INFO - TEST-OK | dromaeo_css | took 1122440ms 12:59:36 INFO - TEST-START | kraken 12:59:36 INFO - operating with platform_type : linux_ 12:59:36 INFO - Initialising browser for kraken test... 12:59:36 INFO - TEST-INFO | started process 18417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYU466/profile http://localhost:50027/getInfo.html) 12:59:41 INFO - PROCESS | 18417 | JavaScript error: , line 0: uncaught exception: undefined 12:59:43 INFO - PROCESS | 18417 | __metrics Screen width/height:1600/1200 12:59:43 INFO - PROCESS | 18417 | colorDepth:24 12:59:43 INFO - PROCESS | 18417 | Browser inner width/height: 1024/697 12:59:43 INFO - PROCESS | 18417 | __metrics 12:59:44 ERROR - PROCESS | 18417 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:59:45 INFO - TEST-INFO | 18417: exit 0 12:59:45 INFO - Browser initialized. 12:59:45 INFO - Running cycle 1/1 for kraken test... 12:59:45 INFO - TEST-INFO | started process 18541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYU466/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:57 INFO - PROCESS | 18541 | RSS: Main: 166158336 12:59:57 INFO - PROCESS | 18541 | 13:00:00 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-beat-detection) 13:00:01 INFO - PROCESS | 18541 | RSS: Main: 171122688 13:00:01 INFO - PROCESS | 18541 | 13:00:04 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-dft) 13:00:04 INFO - PROCESS | 18541 | RSS: Main: 170373120 13:00:04 INFO - PROCESS | 18541 | 13:00:07 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-fft) 13:00:08 INFO - PROCESS | 18541 | RSS: Main: 166223872 13:00:08 INFO - PROCESS | 18541 | 13:00:10 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-oscillator) 13:00:11 INFO - PROCESS | 18541 | RSS: Main: 166932480 13:00:11 INFO - PROCESS | 18541 | 13:00:13 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:00:14 INFO - PROCESS | 18541 | RSS: Main: 167362560 13:00:14 INFO - PROCESS | 18541 | 13:00:17 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50027/tests/kraken/driver.html?testName=imaging-darkroom) 13:00:17 INFO - PROCESS | 18541 | RSS: Main: 167178240 13:00:17 INFO - PROCESS | 18541 | 13:00:21 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50027/tests/kraken/driver.html?testName=imaging-desaturate) 13:00:22 INFO - PROCESS | 18541 | RSS: Main: 165068800 13:00:22 INFO - PROCESS | 18541 | 13:00:24 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50027/tests/kraken/driver.html?testName=json-parse-financial) 13:00:25 INFO - PROCESS | 18541 | RSS: Main: 166768640 13:00:25 INFO - PROCESS | 18541 | 13:00:27 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:00:27 INFO - PROCESS | 18541 | RSS: Main: 166961152 13:00:27 INFO - PROCESS | 18541 | 13:00:29 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:00:30 INFO - PROCESS | 18541 | RSS: Main: 167448576 13:00:30 INFO - PROCESS | 18541 | 13:00:32 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:00:33 INFO - PROCESS | 18541 | RSS: Main: 167976960 13:00:33 INFO - PROCESS | 18541 | 13:00:36 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:00:36 INFO - PROCESS | 18541 | RSS: Main: 168386560 13:00:36 INFO - PROCESS | 18541 | 13:00:39 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:00:40 INFO - PROCESS | 18541 | RSS: Main: 168136704 13:00:40 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50027/tests/kraken/driver.html?testName=ai-astar) 13:00:42 INFO - PROCESS | 18541 | RSS: Main: 168923136 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | __start_tp_report 13:00:42 INFO - PROCESS | 18541 | _x_x_mozilla_page_load 13:00:42 INFO - PROCESS | 18541 | _x_x_mozilla_page_load_details 13:00:42 INFO - PROCESS | 18541 | |i|pagename|runs| 13:00:42 INFO - PROCESS | 18541 | |0;ai-astar;107;115;108;115;114;114;115;113;114;115 13:00:42 INFO - PROCESS | 18541 | |1;audio-beat-detection;163;133;164;190;123;161;153;123;180;129 13:00:42 INFO - PROCESS | 18541 | |2;audio-dft;163;164;165;177;164;163;164;163;163;164 13:00:42 INFO - PROCESS | 18541 | |3;audio-fft;76;78;75;176;78;76;78;77;162;77 13:00:42 INFO - PROCESS | 18541 | |4;audio-oscillator;86;85;151;88;87;87;148;86;87;132 13:00:42 INFO - PROCESS | 18541 | |5;imaging-gaussian-blur;119;118;118;118;119;119;118;121;120;117 13:00:42 INFO - PROCESS | 18541 | |6;imaging-darkroom;149;147;148;147;148;149;148;150;150;147 13:00:42 INFO - PROCESS | 18541 | |7;imaging-desaturate;96;96;95;96;96;96;96;97;96;96 13:00:42 INFO - PROCESS | 18541 | |8;json-parse-financial;61;63;66;67;64;65;63;68;61;61 13:00:42 INFO - PROCESS | 18541 | |9;json-stringify-tinderbox;66;67;66;67;66;65;65;66;66;66 13:00:42 INFO - PROCESS | 18541 | |10;stanford-crypto-aes;81;82;92;80;81;80;81;80;85;80 13:00:42 INFO - PROCESS | 18541 | |11;stanford-crypto-ccm;138;132;135;141;128;132;137;136;170;134 13:00:42 INFO - PROCESS | 18541 | |12;stanford-crypto-pbkdf2;170;172;171;171;172;169;170;172;165;182 13:00:42 INFO - PROCESS | 18541 | |13;stanford-crypto-sha256-iterative;69;68;70;68;69;68;70;67;67;71 13:00:42 INFO - PROCESS | 18541 | __end_tp_report 13:00:42 INFO - PROCESS | 18541 | __start_cc_report 13:00:42 INFO - PROCESS | 18541 | _x_x_mozilla_cycle_collect,984 13:00:42 INFO - PROCESS | 18541 | __end_cc_report 13:00:42 INFO - PROCESS | 18541 | __startTimestamp1469649642415__endTimestamp 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | ------- Summary: start ------- 13:00:42 INFO - PROCESS | 18541 | Number of tests: 14 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:2.98 (2.6%) stddev-sans-first:2.24 13:00:42 INFO - PROCESS | 18541 | Values: 107.0 115.0 108.0 115.0 114.0 114.0 115.0 113.0 114.0 115.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:162.00 stddev:23.91 (14.8%) stddev-sans-first:25.02 13:00:42 INFO - PROCESS | 18541 | Values: 163.0 133.0 164.0 190.0 123.0 161.0 153.0 123.0 180.0 129.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.27 (2.6%) stddev-sans-first:4.47 13:00:42 INFO - PROCESS | 18541 | Values: 163.0 164.0 165.0 177.0 164.0 163.0 164.0 163.0 163.0 164.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#3] audio-fft Cycles:10 Average:95.30 Median:77.00 stddev:39.00 (50.6%) stddev-sans-first:40.73 13:00:42 INFO - PROCESS | 18541 | Values: 76.0 78.0 75.0 176.0 78.0 76.0 78.0 77.0 162.0 77.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.50 stddev:28.01 (32.4%) stddev-sans-first:28.97 13:00:42 INFO - PROCESS | 18541 | Values: 86.0 85.0 151.0 88.0 87.0 87.0 148.0 86.0 87.0 132.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 13:00:42 INFO - PROCESS | 18541 | Values: 119.0 118.0 118.0 118.0 119.0 119.0 118.0 121.0 120.0 117.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.16 (0.8%) stddev-sans-first:1.20 13:00:42 INFO - PROCESS | 18541 | Values: 149.0 147.0 148.0 147.0 148.0 149.0 148.0 150.0 150.0 147.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:00:42 INFO - PROCESS | 18541 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.50 stddev:2.56 (4.0%) stddev-sans-first:2.49 13:00:42 INFO - PROCESS | 18541 | Values: 61.0 63.0 66.0 67.0 64.0 65.0 63.0 68.0 61.0 61.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:00:42 INFO - PROCESS | 18541 | Values: 66.0 67.0 66.0 67.0 66.0 65.0 65.0 66.0 66.0 66.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.00 stddev:3.77 (4.6%) stddev-sans-first:3.97 13:00:42 INFO - PROCESS | 18541 | Values: 81.0 82.0 92.0 80.0 81.0 80.0 81.0 80.0 85.0 80.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:136.50 stddev:11.71 (8.6%) stddev-sans-first:12.42 13:00:42 INFO - PROCESS | 18541 | Values: 138.0 132.0 135.0 141.0 128.0 132.0 137.0 136.0 170.0 134.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.50 stddev:4.27 (2.5%) stddev-sans-first:4.50 13:00:42 INFO - PROCESS | 18541 | Values: 170.0 172.0 171.0 171.0 172.0 169.0 170.0 172.0 165.0 182.0 13:00:42 INFO - PROCESS | 18541 | 13:00:42 INFO - PROCESS | 18541 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 13:00:42 INFO - PROCESS | 18541 | Values: 69.0 68.0 70.0 68.0 69.0 68.0 70.0 67.0 67.0 71.0 13:00:42 INFO - PROCESS | 18541 | -------- Summary: end -------- 13:00:42 INFO - PROCESS | 18541 | 13:00:43 INFO - TEST-INFO | 18541: exit 0 13:00:43 INFO - TEST-OK | kraken | took 67296ms 13:00:43 INFO - SUITE-END | took 1189s 13:00:44 INFO - Completed test suite (00:19:50) 13:00:44 INFO - javascript benchmark 13:00:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6273.559185072008, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.8688065596716, 2628.9746998670516, 2653.204038788363, 2655.933601659958, 2663.560512515436, 4640.489546149929, 4720.4571474280465, 4721.197396442604, 4748.857534273969, 4753.453352864417, 4763.809447622091, 4792.424909010923, 4800.5679488846, 4841.128596852565, 4851.587615052725, 4231.466463123754, 4358.65130789536, 4510.661700372469, 4513.819447222108, 4514.796834142455, 4475.955240447603, 4483.34991426243, 4484.551544845522, 4487.506374298824, 4526.569975852289, 4282.528921818597, 4361.0, 4413.139437809628, 4470.418845550058, 4471.374007638933, 4340.65274778017, 4342.457192850894, 4344.4352234209355, 4436.778161091965, 4471.016376397188, 4345.044090300129, 4358.869233922987, 4359.17175736609, 4362.454693163355, 4389.253826849412, 4708.105459962596, 4722.645801564862, 4722.976385118087, 4781.187198176319, 4817.735024573647, 5114.590832733373, 5120.61595380348, 5122.769475373617, 5132.153194722866, 5182.922256166161, 5171.965606878639, 5176.7929282828645, 5180.766865491024, 5200.29795977542, 5212.166053431432, 4675.368825208588, 4711.081339138869, 4733.053389322149, 4764.785584648699, 4780.091782561302, 5167.586593072545, 5176.19768935808, 5185.974070129625, 5187.3399467939935, 5192.402873669501, 4985.601151907911, 4988.301637770715, 4992.850214493571, 4993.0762808879745, 4995.25071239317, 4972.403311602631, 5107.565856902131, 5129.743512824344, 5135.922961155586, 5178.585713143015, 5107.7446127693465, 5110.693358398508, 5117.488251174853, 5132.794688212504, 5142.820001299937, 5119.436861945183, 5126.5898728101665, 5138.871528211825, 5146.125158723026, 5175.223716442564, 4247.5752424757275, 4322.243607368698, 4354.804033818423, 4357.150355680612, 4386.320120381346, 3761.8495260189284, 3763.6989040876665, 3774.8490060397826, 3807.6573108420375, 3812.599677033927, 4375.759333236702, 4396.824127034883, 4416.668749843775, 4426.0, 4445.355423463644, 4967.428745694219, 5033.672811267256, 5098.617603679665, 5105.387353517602, 5194.1429664105, 4398.115806071781, 4409.382686423904, 4417.050334178167, 4424.004598965207, 4449.57729015743, 4621.0, 4630.907381852411, 4646.117237724821, 4653.534646535387, 4700.412448443944, 4661.86014419568, 4729.3851799265185, 4764.118638051971, 4778.641601879943, 4787.61699064067, 5064.5948324134715, 5064.873378165576, 5082.720450375265, 5082.974585127198, 5128.102582048201, 4721.409823772028, 4745.9050818984115, 4765.070811191785, 4804.975975120102, 4812.975935120302, 4912.484189160086, 4979.103761322852, 4982.950170498394, 5011.574016208518, 5074.3657042869645, 5160.48395160481, 5169.457206993212, 5175.715335656575, 5191.532762051434, 5256.868578285574, 4988.975055124701, 5040.823571174991, 5050.065737838511, 5052.0, 5098.439171691185, 4866.902661946812, 4938.259261110862, 4943.110240156806, 5034.244863270539, 5049.0, 4832.130216561053, 4904.460509343898, 4907.3620429343955, 4917.311576379381, 4934.136526107845, 5035.420926593342, 5064.772085256099, 5071.442141364373, 5107.744612769272, 5133.79464821403, 4873.488283730299, 4876.731779752005, 4919.819243381634, 4930.802767889388, 4982.352294201731], "value": 4693.753460874618, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.3101826189869, 550.8375029366337, 593.623049363654, 599.7840777320162, 601.9548533859959, 32107.678923210762, 35203.82398088009, 35223.99999999997, 35253.82373088138, 35266.64733352666, 35134.64865351345, 35896.282074358496, 35903.46144807823, 36036.2792744145, 36072.63927360726, 7338.229485903983, 7571.24287571244, 7594.316511513963, 7616.314531692146, 7651.732189373373, 7457.589832559207, 7578.317951384374, 7609.809754756147, 7659.310662040415, 7662.885056724153, 7671.347935425496, 7723.22767723226, 7725.884111738328, 7726.0342457192855, 7745.6127193640095, 7638.770836874903, 7649.655765490566, 7682.078150621961, 7683.346915512188, 7697.4226932980255, 7480.102387713455, 7599.088109426849, 7599.506032107895, 7625.389968802482, 7632.885506717348, 33502.0, 33672.6632733672, 33951.32097358039, 34034.82982585096, 34039.0, 2665.375089877765, 2877.6259086318855, 2900.10096869971, 3083.398737246238, 3191.4734068878606, 27365.45269094607, 27720.0, 27811.86094069537, 27816.582751258746, 27875.16374508768, 3333.3666603345287, 3344.0, 3406.114410253327, 3544.663256990582, 3546.219831637036, 214615.0, 214913.0, 215189.0, 215806.92096539575, 216585.0, 30663.8466807669, 31471.685283146875, 31672.524912126337, 46047.309290360674, 46798.76600616975, 32590.185245369055, 32914.3417131656, 33008.83495582555, 33023.174420639196, 33116.0, 12578.874211257771, 12630.115891887663, 12711.110222284537, 12740.299283539309, 12775.297358645365, 10413.219008574388, 10433.373997560171, 10481.423521706227, 10525.578976840994, 10543.683689489328, 7757.301842834172, 7792.181820908723, 7813.140554538996, 7837.05955285358, 7867.331276841533, 3056.1595561220843, 3066.647335556395, 3096.2723759916403, 3127.1712996056062, 3137.1216059503377, 869.9782505437415, 891.741394995457, 927.4713413354458, 965.792354643741, 979.9853002204973, 28038.0, 28237.43525129486, 28427.857860710978, 28701.85649071741, 28959.85520072386, 829.8589239829244, 956.063058202965, 970.5632465390603, 979.1628157924872, 1018.9796204076025, 13135.277559734306, 13842.307884605729, 14107.36516856744, 14155.221462819438, 14262.786058209134, 418780.0, 422156.0, 424289.0, 424661.0, 425471.0, 48360.5163948356, 48591.0, 48771.0, 48803.75598121987, 49146.0, 1141.680329507739, 1184.3012622552562, 1195.802692555736, 1203.8555373355252, 1210.5460452330376, 25310.0, 25923.22230333093, 26927.86536067307, 27585.172444826687, 27632.585511216945, 39382.2123557533, 39722.0, 39772.0, 39838.80080599579, 39844.40233396443, 276959.0, 277462.0, 348724.0, 348872.0, 348979.0, 24446.87776561177, 24722.629160562246, 24828.875855620605, 24839.0, 24919.75080249247, 40476.80823886368, 40742.79628601957, 41100.1779964405, 41205.793971029954, 41605.37591936184, 34131.14672133217, 35477.64522354847, 36023.0, 39008.41487377748, 41122.0, 28970.565441518815, 29056.418871622027, 29587.704122959356, 29675.40649186961, 30067.248318792204, 35570.46644300286, 35950.0, 36363.45454818127, 36625.0, 39307.0, 29994.400111998075, 32240.83879580587, 33431.0, 33817.0, 33863.49204761881, 25269.24192274235, 25843.741562584135, 25845.48309033771, 25852.35369115712, 25940.61089083703], "value": 15822.872453224216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.63369729178936, 364.275092565794, 370.9035650730809, 379.6734808065065, 386.14468951272926, 15911.920440397796, 16527.25627346771, 17344.132793360328, 17503.299868005266, 17568.29726810926, 16164.434244801434, 16184.75722864158, 16510.422135225268, 16521.173941302946, 16940.66118677626, 5034.395872495296, 5231.607629427789, 5254.947450525484, 5267.3679158500845, 5286.577073834103, 5145.794168233266, 5225.6864588124645, 5225.895482090375, 5264.947350526503, 5281.0, 5442.047641662713, 5554.750036248379, 5584.022796010702, 5588.776448942058, 5589.524890384302, 5555.527780138673, 5572.0, 5580.107182850745, 5854.18041474194, 6053.636781793062, 5325.908188821282, 5361.919571206435, 5366.087765079946, 5377.220303056035, 5381.730913454312, 19966.80033199664, 20489.795102049087, 20940.58118837615, 21102.683459748117, 21142.0, 1825.187791432813, 1898.9240430382767, 1916.7508223930938, 1997.2011195521761, 2402.4354276745125, 8975.640974361018, 9010.909890901072, 9037.277017838556, 9630.422174669473, 9683.515824208831, 1712.297957837293, 1763.867709921761, 1800.5138612574663, 1836.8622353323553, 1847.8521718262507, 71922.0, 72179.63910180469, 72189.63905180493, 73839.63080184565, 75701.0, 9481.288903332277, 9596.424214547149, 9756.707298781048, 10069.899301007043, 10291.382517049002, 13636.113652612747, 13662.18026918388, 13692.110012849133, 13712.0, 13717.108387954951, 6736.494762892705, 6750.831229219309, 6936.445084393236, 7030.859382812315, 7037.824054398681, 6334.493240540838, 6387.872242555123, 6525.967370163119, 6537.607743535403, 6540.901886471706, 4149.460570125864, 4269.466316710411, 4324.243257429937, 4361.454818147731, 4396.626286765597, 1795.353672677835, 1797.191263931236, 1800.2798880447663, 1832.4136276391428, 1847.0949234875084, 843.20317300152, 843.3885433060982, 854.1501206299647, 883.6730409748305, 943.9764005899907, 17107.657846842994, 17159.485215443558, 17873.0, 18145.274189032556, 18234.544136396697, 834.2283387866321, 836.272442974616, 845.4927043773687, 848.6817443458702, 854.2909385210261, 8358.498490090493, 9621.374610650286, 9901.950490247647, 10191.286609937382, 10231.641892533726, 376882.0, 386818.0, 387066.0, 389642.0, 392143.0, 75143.62428187823, 75393.62303188558, 76860.61569692116, 77043.0661240491, 80205.59897200477, 885.4996926736374, 898.9685361012333, 913.1735779119907, 915.9267258619294, 917.2066162769156, 15293.235338232822, 15537.766933496232, 15981.8401815985, 16287.348506059625, 16312.836871631607, 37508.81245593754, 38134.42798358083, 38176.61823381731, 38500.22999539937, 39042.41436378514, 52323.73838130937, 52887.73556132195, 53079.203811942076, 54380.45619543754, 55276.447235528736, 6050.213472248755, 7154.67803948834, 7186.640667966476, 7357.668904899399, 7553.433492488195, 11601.767964640829, 11813.0, 12118.878811212127, 12355.382230888239, 12365.690857728629, 5178.922316165336, 9684.32209745311, 10211.285210035227, 10246.436445995541, 10717.785644286914, 10169.694909152737, 10173.949130254301, 10244.59021639156, 10280.948595256976, 10492.580296788043, 9818.901810981799, 10021.849672254777, 10056.296059276074, 10074.69775906724, 10319.638812641522, 7157.176924653523, 7367.2264412235945, 7429.665665045194, 7455.589942553212, 7618.542887426772, 8136.430449868452, 9979.501024948579, 10229.437380943822, 10396.272260941661, 10593.52329145175], "value": 8189.146946874574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.4519564771913, 1416.1573863551187, 1456.1990905002247, 1606.975895361569, 1648.6372997940457, 6751.628660423675, 7301.0, 7422.480426370156, 7799.844003119934, 7807.984961954945, 7556.848863022737, 7840.490368126082, 7853.410994175431, 7855.135935047155, 7856.685732570704, 2125.511132439544, 2147.194801949261, 2161.167950339123, 2162.50262439639, 2164.9891750541224, 2109.493721506835, 2145.9356219313445, 2175.815055720258, 2186.9453263668374, 2192.7478339990867, 2153.752318483371, 2154.8491605587615, 2166.599179151854, 2176.325339144862, 2181.8690878547336, 2120.720225757317, 2131.7761635028255, 2140.7003019577273, 2146.1737231165957, 2146.3024517032027, 2041.5100375909824, 2101.81083702466, 2107.5679485705396, 2133.232036466871, 2135.7010018597407, 7848.2151784821635, 7878.921210787876, 7895.447318687694, 7896.328812050982, 7896.842063158705, 4349.2388831954595, 4492.415985921842, 4493.460784705823, 4497.775111244425, 4505.954940450586, 2704.6754389473194, 2711.30861630283, 2752.7474998875464, 2790.3582176099612, 2792.5252707039854, 903.5482258870564, 945.7068308824287, 946.4983558713893, 957.4111921168501, 969.7042402067367, 10442.164626829912, 10455.477226138739, 10465.1627869771, 10512.947435262851, 10516.211284153718, 3953.743006704555, 4067.1052368478886, 4160.438340824011, 4224.514180869178, 4231.2383770920915, 8946.642134314685, 9049.321300902327, 9057.728268151966, 9079.092090790868, 9086.54567271647, 4416.558344165622, 4466.218411777926, 4467.374567560544, 4483.14820184164, 4486.035502367007, 3500.2299494111253, 3804.752691075071, 3876.903077423087, 4024.4969378827645, 4039.0, 3556.928861422757, 3565.3047655707405, 3687.3178461984617, 3712.9443058354145, 3767.6232376762105, 1156.5258244120039, 1171.800793865045, 1172.372780562395, 1173.1318824070127, 1181.6927598824368, 744.140517702055, 746.7796999885047, 798.7060961242707, 799.5043073294595, 833.954132522717, 5131.948680513147, 5135.563477104413, 5163.845084647466, 5329.626926115135, 5377.193420986883, 392.22731219497547, 392.2703770985964, 393.5788706084462, 395.83572817280503, 400.21557746816563, 3660.816959152085, 3747.550293964687, 3747.6439738224826, 3763.1532905096683, 3784.6972242220554, 9335.346525743133, 9622.0, 9734.0, 9745.025497450199, 9747.415155090717, 9639.807203855884, 9647.469389183521, 9671.516424178762, 9671.854922176173, 9680.661176858775, 7378.5941773202985, 7415.1101867776215, 7506.061742282215, 7519.210482899326, 7525.0, 5025.070361983045, 5048.444671086251, 5067.41724701664, 5169.4830516948, 5231.3199284092825, 8789.472631642122, 8848.690295839615, 8921.598528066123, 8995.505247211204, 9014.504202268938, 8773.605187766438, 9030.63877444895, 9149.5882685278, 9192.954035230048, 9206.9539652304, 5810.070388737781, 6141.9078713818435, 6325.715342809676, 6381.425671689571, 6500.869982600227, 7334.96332518334, 7369.852602948018, 7394.7781566553085, 7396.815079623052, 7400.48196626231, 6086.482648974887, 6300.779472718433, 6351.841203969938, 6380.819548383564, 6475.902861457176, 6210.4100110489435, 6267.059941008885, 6272.498200143887, 6292.685365731787, 6332.271788744353, 5940.495057919952, 6049.939500604937, 6056.636601803906, 6064.151018857452, 6079.969600151971, 4595.563421474954, 4613.446386433515, 4617.6536759742485, 4638.049199913942, 4685.1332503486965, 4526.615237704832, 4536.5236650151255, 4632.328312394751, 4714.151452738402, 4744.288356746378], "value": 3989.0956191519435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.5225986162279, 304.368435496345, 308.4309449066473, 310.81661819526477, 311.4502902377304, 5143.434222235555, 5156.550638446736, 5170.276161337416, 5184.818531351403, 5195.766190521426, 5057.595392368611, 5061.19020956647, 5077.679803251153, 5084.034033533635, 5105.923411148827, 3714.090047938252, 3791.4312853072124, 3862.5515431713106, 3920.882373528799, 3933.0, 3873.6513713765758, 3910.667593254577, 3911.8044097794996, 3913.3738601823716, 3935.803209839511, 3860.4209368594657, 3902.414637804324, 3915.490986171794, 3916.0992971616547, 3927.6857851371824, 3790.5451345838674, 3862.343401621703, 3894.201688653819, 3935.291647503448, 3941.1132495188494, 3410.18155642644, 3416.572928383952, 3418.8461519231696, 3428.502867084284, 3429.0, 4935.481774413671, 4951.851444456672, 4974.10466116099, 4976.681179487438, 4976.825811096631, 4397.450318710161, 4468.19572476954, 4496.842610508649, 4500.459944806611, 4510.075434535912, 5253.763580638881, 5257.842264732064, 5291.788328466857, 5306.850725456196, 5309.548688361494, 3749.2876353492748, 3749.4938183345444, 3750.4374343848367, 3759.8496060157563, 3763.153290509641, 5379.408265090798, 5531.3915469298345, 5572.219889215513, 5589.301337332833, 5594.860128496779, 3800.0, 3842.731008829411, 3867.284552357823, 3874.49631547897, 3881.340172170738, 3884.7863367515056, 3920.157166209279, 3922.705507182623, 3925.784081875467, 3929.685625149981, 4441.578050085237, 4463.531329210451, 4497.235469970113, 4506.774661266923, 4508.752018638941, 5154.92267615986, 5239.397469291081, 5253.947460525423, 5312.415634280226, 5344.198370244417, 1326.9402876870563, 1347.8113064171023, 1350.2033800058014, 1351.2433037499031, 1352.959411217665, 855.2003876375609, 880.6873559886149, 891.585412783046, 894.2845723421367, 901.6979311930446, 4401.22978478765, 4474.597286244254, 4630.421197350332, 4664.55686709762, 4668.719876807402, 5456.863578410492, 5482.5613950883835, 5528.75120619573, 5532.8186292881755, 5564.190084007631, 4634.330884256187, 4705.0, 4705.858824235278, 4724.102420540086, 4739.1706451371565, 2849.28767808048, 2904.4626744051993, 2919.3431477917297, 2932.4868148074, 2938.397628486155, 5105.285260063594, 5145.4597267287145, 5169.767360468788, 5183.50756678115, 5205.73971301441, 5303.602229832778, 5591.664500130005, 5612.867110497985, 5658.575606829504, 5678.659280443187, 5084.41529224144, 5103.260027296095, 5127.743612819419, 5140.126178549581, 5141.434442211354, 5549.889002219852, 5554.2779438672715, 5580.386157522588, 5596.384397716167, 5610.186522954067, 5238.659487133325, 5397.190421436816, 5405.162199859028, 5413.621046526863, 5422.349318081698, 5134.45966210128, 5160.819371321985, 5187.29971453864, 5190.40310364313, 5203.973980130075, 3797.4873392091713, 3819.217060502646, 3819.331616967075, 3827.3876179811095, 3832.1186127190344, 5381.946180538144, 5449.836504904859, 5488.396276409512, 5547.223388725501, 5593.622710348167, 5305.70818604965, 5323.920141197807, 5366.6779993200535, 5411.810586629449, 5429.484199001088, 5340.75966581497, 5369.624126311121, 5397.487238712316, 5402.51377376038, 5436.266104075899, 5030.698158110525, 5273.367195936512, 5273.604479664117, 5295.364556253275, 5298.28473156119, 5165.535101840853, 5285.365756109291, 5386.084365657769, 5401.837944861661, 5442.0, 5180.507851754077, 5220.425753167073, 5222.843314700565, 5224.164133738584, 5226.63413561047], "value": 3995.0879659903394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2553406106126, 606.193762296146, 682.9590224586522, 711.2629884966127, 712.9626393597316, 11363.147763917697, 11962.461689223985, 11973.461194246258, 13335.199888006702, 13999.230042347692, 14337.283135843192, 14365.0, 14395.568132956001, 14483.5654930352, 14493.63765905853, 776.3323541754102, 796.6096612659784, 797.7088362747613, 797.9162187970267, 800.6237068577789, 632.1118828046602, 760.0423466432308, 780.3445106110865, 787.0791174326024, 790.5414859381544, 822.2476434062826, 823.3125340340822, 824.9340052795792, 825.8430898129366, 827.7227128911821, 814.5194335342118, 819.8606236939705, 821.0393839208141, 821.3183058061854, 823.4853216739538, 601.5217901768104, 601.8405122642504, 602.1509671363357, 602.5300265792645, 605.1255935173676, 12046.638600841989, 12100.213486123463, 12133.272003679807, 12135.514579416813, 12139.028877689763, 12548.874511254862, 12596.874031259662, 12600.306983115925, 12727.172733772275, 12746.617601471879, 9848.359856609297, 9863.792845382413, 9935.950320248425, 10059.144972677332, 10123.240756943258, 3233.7898036627544, 3258.771885967983, 3261.1194977356217, 3305.50552741819, 3314.3537010283003, 64510.3548964509, 65705.3429465704, 66317.99999999952, 66784.3321566783, 68393.0, 9390.765230869147, 9526.428414295164, 9603.327767056378, 9699.369540979813, 9728.027197280357, 17418.91290543539, 17470.825291746918, 17687.557811054827, 17716.468505944842, 18460.907695461436, 6273.1844860167885, 6485.4811615070685, 6504.154459920274, 6571.67141642916, 6583.769568065095, 3568.232829941575, 3598.190407158421, 3789.829457674411, 3862.439946207784, 3891.338472459632, 2713.796465265113, 2808.69104398516, 2819.901303454369, 2824.6045553622507, 2826.632537770118, 493.52374958164825, 503.4260942525524, 506.2987761949726, 516.5273774496294, 518.6913786297147, 467.31071669288207, 523.3876364653364, 524.3943245551394, 537.8494021673938, 573.7217449536971, 7647.273509016634, 7829.491083079582, 7852.214778522216, 8270.545120018456, 8562.571871406404, 517.2809794385806, 529.8728305206722, 555.5916401444935, 582.2198254339206, 590.8995470769979, 3641.453781932731, 3768.7550309229814, 3794.0894185395305, 3887.5723670396233, 4010.6590939769862, 95520.52239738757, 97227.51386243165, 98453.50773246231, 101185.8932696061, 101473.49263253636, 84201.57899210465, 85700.57149714336, 85924.0, 86337.56831215929, 87738.0, 73560.05759769656, 75091.24908750952, 79193.0, 79301.60349198332, 79747.0, 7278.417726581755, 7328.267173282629, 7406.962965185139, 7550.207228240955, 7733.8839917400155, 46513.069738605715, 46845.53154468412, 46875.0, 46919.0, 46920.0, 56561.717191415424, 63457.682711586145, 67998.32001680118, 68113.31886681268, 69894.65052674703, 9444.622215111318, 9564.0, 9573.425594464354, 9595.42427454355, 9690.806183876142, 10632.0, 10647.574097036031, 10664.200184986003, 10762.838557421488, 10836.078933290759, 9803.313768036169, 9862.161716254199, 10004.449755263531, 10025.949870250603, 10036.698899033041, 9557.426554406758, 9732.756681082747, 9741.220702343653, 9753.0, 9816.852747208655, 9982.900170998197, 10027.147692445931, 10077.445740484343, 10100.242481813746, 10595.046445819913, 8190.631421586162, 8313.584320783815, 8518.105598912272, 8661.91338086611, 8667.479951202948, 8399.832003360021, 8634.438761480735, 8660.40406640088, 8710.303175746052, 8926.86609700868], "value": 6289.189357906402, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 108.0, 115.0, 114.0, 114.0, 115.0, 113.0, 114.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 164.0, 190.0, 123.0, 161.0, 153.0, 123.0, 180.0, 129.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 177.0, 164.0, 163.0, 164.0, 163.0, 163.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 176.0, 78.0, 76.0, 78.0, 77.0, 162.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 151.0, 88.0, 87.0, 87.0, 148.0, 86.0, 87.0, 132.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 121.0, 120.0, 117.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 150.0, 150.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 66.0, 67.0, 64.0, 65.0, 63.0, 68.0, 61.0, 61.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 92.0, 80.0, 81.0, 80.0, 81.0, 80.0, 85.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 135.0, 141.0, 128.0, 132.0, 137.0, 136.0, 170.0, 134.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 171.0, 171.0, 172.0, 169.0, 170.0, 172.0, 165.0, 182.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 68.0, 69.0, 68.0, 70.0, 67.0, 67.0, 71.0], "value": 68.7, "unit": "score"}]}]} 13:00:44 INFO - Return code: 0 13:00:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:00:44 ERROR - # TBPL SUCCESS # 13:00:44 INFO - Running post-action listener: _resource_record_post_action 13:00:44 INFO - [mozharness: 2016-07-27 20:00:44.213977Z] Finished run-tests step (success) 13:00:44 INFO - Running post-run listener: _resource_record_post_run 13:00:44 INFO - Total resource usage - Wall time: 1214s; CPU: 14.0%; Read bytes: 4096; Write bytes: 542126080; Read time: 1108; Write time: 3523748 13:00:44 INFO - TinderboxPrint: CPU usage
13.6% 13:00:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 1,108 13:00:44 INFO - TinderboxPrint: I/O write bytes / time
542,126,080 / 3,523,748 13:00:44 INFO - TinderboxPrint: CPU idle
8,366.1 (86.3%) 13:00:44 INFO - TinderboxPrint: CPU user
1,218.4 (12.6%) 13:00:44 INFO - TinderboxPrint: Swap in / out
0 / 0 13:00:44 INFO - install - Wall time: 21s; CPU: 21.0%; Read bytes: 0; Write bytes: 179376128; Read time: 0; Write time: 1228448 13:00:44 INFO - run-tests - Wall time: 1194s; CPU: 14.0%; Read bytes: 4096; Write bytes: 351215616; Read time: 1108; Write time: 2136704 13:00:44 INFO - Running post-run listener: _upload_blobber_files 13:00:44 INFO - Blob upload gear active. 13:00:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00: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 13:00: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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:00: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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:00:45 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:49 INFO - (blobuploader) - INFO - Done attempting. 13:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:50 INFO - (blobuploader) - INFO - Done attempting. 13:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:51 INFO - (blobuploader) - INFO - Done attempting. 13:00:51 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:51 INFO - Return code: 0 13:00:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:00:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef2e14bd9f69fcd5433f2f34ff104292bf45a14804648b25b4b7931159827acf7eb0407d859a8ddd4abd8bb176b9bed860ca142b0cf416a50fd4a7fbc5f2e6eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55b7f7cfd402d5aaf98ecf972650640e9a136c17cad3b4a4372948d852aa0a120bcca008b2e9f38612f7666e49af46b22c9f944ba5215d424de140aa4027b58a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d493ce8d846446ab27295c3df26487bd73db31e6ef64475ec853730b8ea7d3ad30671cb69483448260202ebf29205505b6d38046e96e99bb3cb2e6df20e7c55c"} 13:00:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:00:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:00:51 INFO - Contents: 13:00:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef2e14bd9f69fcd5433f2f34ff104292bf45a14804648b25b4b7931159827acf7eb0407d859a8ddd4abd8bb176b9bed860ca142b0cf416a50fd4a7fbc5f2e6eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55b7f7cfd402d5aaf98ecf972650640e9a136c17cad3b4a4372948d852aa0a120bcca008b2e9f38612f7666e49af46b22c9f944ba5215d424de140aa4027b58a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d493ce8d846446ab27295c3df26487bd73db31e6ef64475ec853730b8ea7d3ad30671cb69483448260202ebf29205505b6d38046e96e99bb3cb2e6df20e7c55c"} 13:00:51 INFO - Running post-run listener: copy_logs_to_upload_dir 13:00:51 INFO - Copying logs to upload dir... 13:00:51 INFO - mkdir: /builds/slave/test/build/upload/logs 13:00:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.586689 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-27 13:00:51.268178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 13:00:51.271571) ========= 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=33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef2e14bd9f69fcd5433f2f34ff104292bf45a14804648b25b4b7931159827acf7eb0407d859a8ddd4abd8bb176b9bed860ca142b0cf416a50fd4a7fbc5f2e6eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55b7f7cfd402d5aaf98ecf972650640e9a136c17cad3b4a4372948d852aa0a120bcca008b2e9f38612f7666e49af46b22c9f944ba5215d424de140aa4027b58a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d493ce8d846446ab27295c3df26487bd73db31e6ef64475ec853730b8ea7d3ad30671cb69483448260202ebf29205505b6d38046e96e99bb3cb2e6df20e7c55c"} build_url:https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/KAsQ6NnBRXekens3006IuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef2e14bd9f69fcd5433f2f34ff104292bf45a14804648b25b4b7931159827acf7eb0407d859a8ddd4abd8bb176b9bed860ca142b0cf416a50fd4a7fbc5f2e6eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55b7f7cfd402d5aaf98ecf972650640e9a136c17cad3b4a4372948d852aa0a120bcca008b2e9f38612f7666e49af46b22c9f944ba5215d424de140aa4027b58a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d493ce8d846446ab27295c3df26487bd73db31e6ef64475ec853730b8ea7d3ad30671cb69483448260202ebf29205505b6d38046e96e99bb3cb2e6df20e7c55c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 13:00:51.297214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:00:51.297551) ========= 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=33d5923976266a1c518c4bf7000001ab-1469648394.373666-1675394214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:00:51.380326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 13:00:51.380674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 13:00:51.381027) ========= ========= Total master_lag: 0.16 =========