builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1469494860.15 results: success (0) buildid: 20160725171403 builduid: 952eef3ead7d416bb826def79e385853 revision: 4b60c69db493e32e87f89376cb0e918712d64b44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.147516) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.148028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.148489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.177966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.178408) ========= 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=52faae308a556c440401f8e5000001e8-1469494190.594950-198813963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 18:01:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-07-25 18:01:01 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.269329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.269621) ========= 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=52faae308a556c440401f8e5000001e8-1469494190.594950-198813963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.323439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:00.326519) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4b60c69db493e32e87f89376cb0e918712d64b44 --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 4b60c69db493e32e87f89376cb0e918712d64b44 --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=52faae308a556c440401f8e5000001e8-1469494190.594950-198813963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 18:01:01,191 truncating revision to first 12 chars 2016-07-25 18:01:01,191 Setting DEBUG logging. 2016-07-25 18:01:01,191 attempt 1/10 2016-07-25 18:01:01,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4b60c69db493?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 18:01:01,510 unpacking tar archive at: autoland-4b60c69db493/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:01.001024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:01.004436) ========= script_repo_revision: 4b60c69db493e32e87f89376cb0e918712d64b44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:01.004909) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:01.005224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 18:01:01.015660) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-25 18:01:01.016104) ========= /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=52faae308a556c440401f8e5000001e8-1469494190.594950-198813963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:01:01 INFO - MultiFileLogger online at 20160725 18:01:01 in /builds/slave/test 18:01:01 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 18:01:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:01:01 INFO - {'append_to_log': False, 18:01:01 INFO - 'base_work_dir': '/builds/slave/test', 18:01:01 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 18:01:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:01:01 INFO - 'branch': 'Autoland-Non-PGO', 18:01:01 INFO - 'buildbot_json_path': 'buildprops.json', 18:01:01 INFO - 'config_files': ('talos/linux_config.py',), 18:01:01 INFO - 'default_actions': ('clobber', 18:01:01 INFO - 'read-buildbot-config', 18:01:01 INFO - 'download-and-extract', 18:01:01 INFO - 'populate-webroot', 18:01:01 INFO - 'create-virtualenv', 18:01:01 INFO - 'install', 18:01:01 INFO - 'run-tests'), 18:01:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:01:01 INFO - 'download_minidump_stackwalk': True, 18:01:01 INFO - 'download_symbols': 'ondemand', 18:01:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:01:01 INFO - 'tooltool.py': '/tools/tooltool.py', 18:01:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:01:01 INFO - '/tools/misc-python/virtualenv.py')}, 18:01:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:01:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:01:01 INFO - 'installer_path': 'installer.exe', 18:01:01 INFO - 'log_level': 'info', 18:01:01 INFO - 'log_name': 'talos', 18:01:01 INFO - 'log_to_console': True, 18:01:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:01:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:01:01 INFO - 'opt_config_files': (), 18:01:01 INFO - 'pip_index': False, 18:01:01 INFO - 'sps_profile': False, 18:01:01 INFO - 'sps_profile_interval': 0, 18:01:01 INFO - 'suite': 'dromaeojs-e10s', 18:01:01 INFO - 'system_bits': '32', 18:01:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:01:01 INFO - 'title': 'talos-linux64-ix-056', 18:01:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:01:01 INFO - 'use_talos_json': True, 18:01:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:01:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:01:01 INFO - 'work_dir': 'build'} 18:01:01 INFO - [mozharness: 2016-07-26 01:01:01.977091Z] Running clobber step. 18:01:01 INFO - Running pre-action listener: _resource_record_pre_action 18:01:01 INFO - Running main action method: clobber 18:01:01 INFO - rmtree: /builds/slave/test/build 18:01:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:01:02 INFO - Running post-action listener: _resource_record_post_action 18:01:02 INFO - [mozharness: 2016-07-26 01:01:02.455257Z] Finished clobber step (success) 18:01:02 INFO - [mozharness: 2016-07-26 01:01:02.455360Z] Running read-buildbot-config step. 18:01:02 INFO - Running pre-action listener: _resource_record_pre_action 18:01:02 INFO - Running main action method: read_buildbot_config 18:01:02 INFO - Using buildbot properties: 18:01:02 INFO - { 18:01:02 INFO - "project": "", 18:01:02 INFO - "product": "firefox", 18:01:02 INFO - "script_repo_revision": "production", 18:01:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 18:01:02 INFO - "repository": "", 18:01:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 18:01:02 INFO - "buildid": "20160725171403", 18:01:02 INFO - "pgo_build": "False", 18:01:02 INFO - "basedir": "/builds/slave/test", 18:01:02 INFO - "buildnumber": 115, 18:01:02 INFO - "slavename": "talos-linux64-ix-056", 18:01:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:01:02 INFO - "platform": "ubuntu64_hw", 18:01:02 INFO - "scheduler": "tests-autoland-linux64-talos", 18:01:02 INFO - "branch": "autoland", 18:01:02 INFO - "repo_path": "integration/autoland", 18:01:02 INFO - "revision": "4b60c69db493e32e87f89376cb0e918712d64b44", 18:01:02 INFO - "stage_platform": "linux64", 18:01:02 INFO - "builduid": "952eef3ead7d416bb826def79e385853", 18:01:02 INFO - "slavebuilddir": "test" 18:01:02 INFO - } 18:01:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:01:02 INFO - Running post-action listener: _resource_record_post_action 18:01:02 INFO - [mozharness: 2016-07-26 01:01:02.457889Z] Finished read-buildbot-config step (success) 18:01:02 INFO - [mozharness: 2016-07-26 01:01:02.457978Z] Running download-and-extract step. 18:01:02 INFO - Running pre-action listener: _resource_record_pre_action 18:01:02 INFO - Running main action method: download_and_extract 18:01:02 INFO - mkdir: /builds/slave/test/build/tests 18:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:02 INFO - https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:01:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:01:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:01:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:04 INFO - Downloaded 1361 bytes. 18:01:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:01:04 INFO - Using the following test package requirements: 18:01:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:01:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:01:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:01:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'jsshell-linux-x86_64.zip'], 18:01:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:01:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:01:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:01:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:01:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:01:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:01:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:04 INFO - https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:01:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:01:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:01:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:11 INFO - Downloaded 22740990 bytes. 18:01:11 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'] 18:01:11 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 18:01:12 INFO - Return code: 0 18:01:12 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 18:01:12 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')]} 18:01:12 INFO - https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:01:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:01:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:01:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:13 INFO - Downloaded 22740990 bytes. 18:01:13 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'] 18:01:13 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 18:01:15 INFO - Return code: 0 18:01: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')]} 18:01:15 INFO - https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:01:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:01:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:01:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:17 INFO - Downloaded 14413725 bytes. 18:01:17 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'] 18:01:17 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 18:01:17 INFO - Return code: 0 18:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:17 INFO - https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:01:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:01:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:01:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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 18:01:18 INFO - Downloaded 57163344 bytes. 18:01:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:01:18 INFO - mkdir: /builds/slave/test/properties 18:01:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:01:18 INFO - Writing to file /builds/slave/test/properties/build_url 18:01:18 INFO - Contents: 18:01:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:01:19 INFO - Running post-action listener: _resource_record_post_action 18:01:19 INFO - Running post-action listener: set_extra_try_arguments 18:01:19 INFO - [mozharness: 2016-07-26 01:01:19.518732Z] Finished download-and-extract step (success) 18:01:19 INFO - [mozharness: 2016-07-26 01:01:19.518965Z] Running populate-webroot step. 18:01:19 INFO - Running pre-action listener: _resource_record_pre_action 18:01:19 INFO - Running main action method: populate_webroot 18:01:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:01:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:01:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:01:19 INFO - '--tppagecycles', 18:01:19 INFO - '7'], 18:01:19 INFO - 'tests': ['tsvgm']}}, 18:01:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:01:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:01:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:01:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:01:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:01:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:01:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['damp', 'tps']}, 18:01:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'tests': ['damp', 'tps']}, 18:01:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['dromaeo_dom']}, 18:01:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:01:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['basic_compositor_video']}, 18:01:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:01:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['a11yr', 18:01:19 INFO - 'ts_paint', 18:01:19 INFO - 'tpaint', 18:01:19 INFO - 'sessionrestore', 18:01:19 INFO - 'sessionrestore_no_auto_restore', 18:01:19 INFO - 'tabpaint']}, 18:01:19 INFO - 'other-e10s': {'tests': ['a11yr', 18:01:19 INFO - 'ts_paint', 18:01:19 INFO - 'tpaint', 18:01:19 INFO - 'sessionrestore', 18:01:19 INFO - 'sessionrestore_no_auto_restore', 18:01:19 INFO - 'tabpaint']}, 18:01:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:01:19 INFO - 'ts_paint', 18:01:19 INFO - 'tpaint', 18:01:19 INFO - 'sessionrestore', 18:01:19 INFO - 'sessionrestore_no_auto_restore', 18:01:19 INFO - 'tabpaint']}, 18:01:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:01:19 INFO - 'ts_paint', 18:01:19 INFO - 'tpaint', 18:01:19 INFO - 'sessionrestore', 18:01:19 INFO - 'sessionrestore_no_auto_restore', 18:01:19 INFO - 'tabpaint']}, 18:01:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['a11yr', 18:01:19 INFO - 'ts_paint', 18:01:19 INFO - 'tpaint', 18:01:19 INFO - 'sessionrestore', 18:01:19 INFO - 'sessionrestore_no_auto_restore', 18:01:19 INFO - 'tabpaint']}, 18:01:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['a11yr', 18:01:19 INFO - 'ts_paint', 18:01:19 INFO - 'tpaint', 18:01:19 INFO - 'sessionrestore', 18:01:19 INFO - 'sessionrestore_no_auto_restore', 18:01:19 INFO - 'tabpaint']}, 18:01:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['tsvgx', 18:01:19 INFO - 'tsvgr_opacity', 18:01:19 INFO - 'tart', 18:01:19 INFO - 'tscrollx', 18:01:19 INFO - 'cart']}, 18:01:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:01:19 INFO - 'tsvgr_opacity', 18:01:19 INFO - 'tart', 18:01:19 INFO - 'tscrollx', 18:01:19 INFO - 'cart']}, 18:01:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'talos_options': ['--disable-e10s'], 18:01:19 INFO - 'tests': ['tp5o']}, 18:01:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'tests': ['tp5o']}, 18:01:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'talos_options': ['--disable-e10s', 18:01:19 INFO - '--xperf_path', 18:01:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:01:19 INFO - 'tests': ['tp5n']}, 18:01:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:19 INFO - 'talos_options': ['--xperf_path', 18:01:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:01:19 INFO - 'tests': ['tp5n']}}, 18:01:19 INFO - 'talos.zip': {'path': '', 18:01:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:01:19 INFO - Running post-action listener: _resource_record_post_action 18:01:19 INFO - [mozharness: 2016-07-26 01:01:19.540973Z] Finished populate-webroot step (success) 18:01:19 INFO - [mozharness: 2016-07-26 01:01:19.541061Z] Running create-virtualenv step. 18:01:19 INFO - Running pre-action listener: _resource_record_pre_action 18:01:19 INFO - Running main action method: create_virtualenv 18:01:19 INFO - Creating virtualenv /builds/slave/test/build/venv 18:01:19 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 18:01:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:01:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:01:19 INFO - Using real prefix '/usr' 18:01:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:01:20 INFO - Installing distribute.............................................................................................................................................................................................done. 18:01:22 INFO - Installing pip.................done. 18:01:22 INFO - Return code: 0 18:01:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:22 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:22 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 18:01:22 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 18:01:22 INFO - Using env: {'DISPLAY': ':0', 18:01:22 INFO - 'HOME': '/home/cltbld', 18:01:22 INFO - 'LANG': 'en_US.UTF-8', 18:01:22 INFO - 'LANGUAGE': 'en_US:en', 18:01:22 INFO - 'LOGNAME': 'cltbld', 18:01:22 INFO - 'MAIL': '/var/mail/cltbld', 18:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:22 INFO - 'MOZ_NO_REMOTE': '1', 18:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:22 INFO - 'NO_EM_RESTART': '1', 18:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:22 INFO - 'PWD': '/builds/slave/test', 18:01:22 INFO - 'SHELL': '/bin/bash', 18:01:22 INFO - 'SHLVL': '1', 18:01:22 INFO - 'TERM': 'linux', 18:01:22 INFO - 'TMOUT': '86400', 18:01:22 INFO - 'USER': 'cltbld', 18:01:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:22 INFO - '_': '/tools/buildbot/bin/python'} 18:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:22 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 18:01:22 INFO - Cleaning up... 18:01:22 INFO - Return code: 0 18:01:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:22 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:22 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 18:01:22 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 18:01:22 INFO - Using env: {'DISPLAY': ':0', 18:01:22 INFO - 'HOME': '/home/cltbld', 18:01:22 INFO - 'LANG': 'en_US.UTF-8', 18:01:22 INFO - 'LANGUAGE': 'en_US:en', 18:01:22 INFO - 'LOGNAME': 'cltbld', 18:01:22 INFO - 'MAIL': '/var/mail/cltbld', 18:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:22 INFO - 'MOZ_NO_REMOTE': '1', 18:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:22 INFO - 'NO_EM_RESTART': '1', 18:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:22 INFO - 'PWD': '/builds/slave/test', 18:01:22 INFO - 'SHELL': '/bin/bash', 18:01:22 INFO - 'SHLVL': '1', 18:01:22 INFO - 'TERM': 'linux', 18:01:22 INFO - 'TMOUT': '86400', 18:01:22 INFO - 'USER': 'cltbld', 18:01:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:22 INFO - '_': '/tools/buildbot/bin/python'} 18:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:22 INFO - Downloading/unpacking psutil>=3.1.1 18:01:22 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 18:01:22 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 18:01:22 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 18:01:22 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 18:01:22 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 18:01:22 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 18:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:01:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:01:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:01:24 INFO - Installing collected packages: psutil 18:01:24 INFO - Running setup.py install for psutil 18:01:24 INFO - building 'psutil._psutil_linux' extension 18:01:24 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 18:01:24 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 18:01:24 INFO - building 'psutil._psutil_posix' extension 18:01:24 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 18:01:24 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 18:01:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:01:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:01:25 INFO - Successfully installed psutil 18:01:25 INFO - Cleaning up... 18:01:25 INFO - Return code: 0 18:01:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:01: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')]} 18:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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')]} 18:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:25 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:25 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 18:01:25 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 18:01:25 INFO - Using env: {'DISPLAY': ':0', 18:01:25 INFO - 'HOME': '/home/cltbld', 18:01:25 INFO - 'LANG': 'en_US.UTF-8', 18:01:25 INFO - 'LANGUAGE': 'en_US:en', 18:01:25 INFO - 'LOGNAME': 'cltbld', 18:01:25 INFO - 'MAIL': '/var/mail/cltbld', 18:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:25 INFO - 'MOZ_NO_REMOTE': '1', 18:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:25 INFO - 'NO_EM_RESTART': '1', 18:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:25 INFO - 'PWD': '/builds/slave/test', 18:01:25 INFO - 'SHELL': '/bin/bash', 18:01:25 INFO - 'SHLVL': '1', 18:01:25 INFO - 'TERM': 'linux', 18:01:25 INFO - 'TMOUT': '86400', 18:01:25 INFO - 'USER': 'cltbld', 18:01:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:25 INFO - '_': '/tools/buildbot/bin/python'} 18:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:01:25 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 18:01:25 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 18:01:25 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 18:01:25 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 18:01:25 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 18:01:25 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 18:01:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:01:27 INFO - Installing collected packages: mozsystemmonitor 18:01:27 INFO - Running setup.py install for mozsystemmonitor 18:01:27 INFO - Successfully installed mozsystemmonitor 18:01:27 INFO - Cleaning up... 18:01:27 INFO - Return code: 0 18:01:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:27 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:27 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 18:01:27 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 18:01:27 INFO - Using env: {'DISPLAY': ':0', 18:01:27 INFO - 'HOME': '/home/cltbld', 18:01:27 INFO - 'LANG': 'en_US.UTF-8', 18:01:27 INFO - 'LANGUAGE': 'en_US:en', 18:01:27 INFO - 'LOGNAME': 'cltbld', 18:01:27 INFO - 'MAIL': '/var/mail/cltbld', 18:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:27 INFO - 'MOZ_NO_REMOTE': '1', 18:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:27 INFO - 'NO_EM_RESTART': '1', 18:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:27 INFO - 'PWD': '/builds/slave/test', 18:01:27 INFO - 'SHELL': '/bin/bash', 18:01:27 INFO - 'SHLVL': '1', 18:01:27 INFO - 'TERM': 'linux', 18:01:27 INFO - 'TMOUT': '86400', 18:01:27 INFO - 'USER': 'cltbld', 18:01:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:27 INFO - '_': '/tools/buildbot/bin/python'} 18:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:27 INFO - Downloading/unpacking jsonschema==2.5.1 18:01:27 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 18:01:27 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 18:01:27 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 18:01:27 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 18:01:27 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 18:01:27 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 18:01:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:01:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:01:29 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 18:01:29 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 18:01:29 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 18:01:29 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 18:01:29 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 18:01:29 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 18:01:29 INFO - Downloading functools32-3.2.3-2.tar.gz 18:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:01:29 INFO - warning: no files found matching '*.txt' 18:01:29 INFO - no previously-included directories found matching 'build' 18:01:29 INFO - no previously-included directories found matching 'dist' 18:01:29 INFO - no previously-included directories found matching '.git*' 18:01:29 INFO - Installing collected packages: jsonschema, functools32 18:01:29 INFO - Running setup.py install for functools32 18:01:29 INFO - warning: no files found matching '*.txt' 18:01:29 INFO - no previously-included directories found matching 'build' 18:01:29 INFO - no previously-included directories found matching 'dist' 18:01:29 INFO - no previously-included directories found matching '.git*' 18:01:29 INFO - Successfully installed jsonschema functools32 18:01:29 INFO - Cleaning up... 18:01:30 INFO - Return code: 0 18:01:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:30 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:30 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 18:01:30 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 18:01:30 INFO - Using env: {'DISPLAY': ':0', 18:01:30 INFO - 'HOME': '/home/cltbld', 18:01:30 INFO - 'LANG': 'en_US.UTF-8', 18:01:30 INFO - 'LANGUAGE': 'en_US:en', 18:01:30 INFO - 'LOGNAME': 'cltbld', 18:01:30 INFO - 'MAIL': '/var/mail/cltbld', 18:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:30 INFO - 'MOZ_NO_REMOTE': '1', 18:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:30 INFO - 'NO_EM_RESTART': '1', 18:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:30 INFO - 'PWD': '/builds/slave/test', 18:01:30 INFO - 'SHELL': '/bin/bash', 18:01:30 INFO - 'SHLVL': '1', 18:01:30 INFO - 'TERM': 'linux', 18:01:30 INFO - 'TMOUT': '86400', 18:01:30 INFO - 'USER': 'cltbld', 18:01:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:30 INFO - '_': '/tools/buildbot/bin/python'} 18:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:01:30 INFO - Cleaning up... 18:01:30 INFO - Return code: 0 18:01:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:30 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:30 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 18:01:30 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 18:01:30 INFO - Using env: {'DISPLAY': ':0', 18:01:30 INFO - 'HOME': '/home/cltbld', 18:01:30 INFO - 'LANG': 'en_US.UTF-8', 18:01:30 INFO - 'LANGUAGE': 'en_US:en', 18:01:30 INFO - 'LOGNAME': 'cltbld', 18:01:30 INFO - 'MAIL': '/var/mail/cltbld', 18:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:30 INFO - 'MOZ_NO_REMOTE': '1', 18:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:30 INFO - 'NO_EM_RESTART': '1', 18:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:30 INFO - 'PWD': '/builds/slave/test', 18:01:30 INFO - 'SHELL': '/bin/bash', 18:01:30 INFO - 'SHLVL': '1', 18:01:30 INFO - 'TERM': 'linux', 18:01:30 INFO - 'TMOUT': '86400', 18:01:30 INFO - 'USER': 'cltbld', 18:01:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:30 INFO - '_': '/tools/buildbot/bin/python'} 18:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:30 INFO - Downloading/unpacking blobuploader==1.2.4 18:01:30 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 18:01:30 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 18:01:30 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 18:01:30 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 18:01:30 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 18:01:30 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 18:01:32 INFO - Downloading blobuploader-1.2.4.tar.gz 18:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:01:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:01:32 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 18:01:32 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 18:01:32 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 18:01:32 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 18:01:32 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 18:01:32 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 18:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:01:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:01:32 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 18:01:32 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 18:01:32 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 18:01:32 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 18:01:32 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 18:01:32 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 18:01:33 INFO - Downloading docopt-0.6.1.tar.gz 18:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:01:33 INFO - Installing collected packages: blobuploader, requests, docopt 18:01:33 INFO - Running setup.py install for blobuploader 18:01:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:01:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:01:33 INFO - Running setup.py install for requests 18:01:33 INFO - Running setup.py install for docopt 18:01:33 INFO - Successfully installed blobuploader requests docopt 18:01:33 INFO - Cleaning up... 18:01:33 INFO - Return code: 0 18:01:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:33 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')]} 18:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:33 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')]} 18:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:33 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:33 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 18:01:33 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 18:01:33 INFO - Using env: {'DISPLAY': ':0', 18:01:33 INFO - 'HOME': '/home/cltbld', 18:01:33 INFO - 'LANG': 'en_US.UTF-8', 18:01:33 INFO - 'LANGUAGE': 'en_US:en', 18:01:33 INFO - 'LOGNAME': 'cltbld', 18:01:33 INFO - 'MAIL': '/var/mail/cltbld', 18:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:33 INFO - 'MOZ_NO_REMOTE': '1', 18:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:33 INFO - 'NO_EM_RESTART': '1', 18:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:33 INFO - 'PWD': '/builds/slave/test', 18:01:33 INFO - 'SHELL': '/bin/bash', 18:01:33 INFO - 'SHLVL': '1', 18:01:33 INFO - 'TERM': 'linux', 18:01:33 INFO - 'TMOUT': '86400', 18:01:33 INFO - 'USER': 'cltbld', 18:01:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:33 INFO - '_': '/tools/buildbot/bin/python'} 18:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:33 INFO - Running setup.py (path:/tmp/pip-zn3DaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:34 INFO - Running setup.py (path:/tmp/pip-v3RlUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:34 INFO - Running setup.py (path:/tmp/pip-WguJo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:34 INFO - Running setup.py (path:/tmp/pip-OTK67O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:34 INFO - Running setup.py (path:/tmp/pip-unnp0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:34 INFO - Running setup.py (path:/tmp/pip-5xTttf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:34 INFO - Running setup.py (path:/tmp/pip-mhmLyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:34 INFO - Running setup.py (path:/tmp/pip-t7wLXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:34 INFO - Running setup.py (path:/tmp/pip-qNRK2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:34 INFO - Running setup.py (path:/tmp/pip-gdvKIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:34 INFO - Running setup.py (path:/tmp/pip-E92JGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:34 INFO - Running setup.py (path:/tmp/pip-HXNHXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:34 INFO - Running setup.py (path:/tmp/pip-pi2hBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:34 INFO - Running setup.py (path:/tmp/pip-n8zMkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:34 INFO - Running setup.py (path:/tmp/pip-xQaJ6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:35 INFO - Running setup.py (path:/tmp/pip-Z8rp7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:35 INFO - Running setup.py (path:/tmp/pip-6KApeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:01:35 INFO - Running setup.py install for manifestparser 18:01:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:01:35 INFO - Running setup.py install for mozcrash 18:01:35 INFO - Running setup.py install for mozdebug 18:01:35 INFO - Running setup.py install for mozdevice 18:01:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:01:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:01:35 INFO - Running setup.py install for mozfile 18:01:35 INFO - Running setup.py install for mozhttpd 18:01:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:01:35 INFO - Running setup.py install for mozinfo 18:01:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:01:35 INFO - Running setup.py install for mozInstall 18:01:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Running setup.py install for mozleak 18:01:36 INFO - Running setup.py install for mozlog 18:01:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Running setup.py install for moznetwork 18:01:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Running setup.py install for mozprocess 18:01:36 INFO - Running setup.py install for mozprofile 18:01:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Running setup.py install for mozrunner 18:01:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Running setup.py install for mozscreenshot 18:01:36 INFO - Running setup.py install for moztest 18:01:36 INFO - Running setup.py install for mozversion 18:01:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:01:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:01:36 INFO - Cleaning up... 18:01:37 INFO - Return code: 0 18:01:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:37 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:37 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 18:01:37 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 18:01:37 INFO - Using env: {'DISPLAY': ':0', 18:01:37 INFO - 'HOME': '/home/cltbld', 18:01:37 INFO - 'LANG': 'en_US.UTF-8', 18:01:37 INFO - 'LANGUAGE': 'en_US:en', 18:01:37 INFO - 'LOGNAME': 'cltbld', 18:01:37 INFO - 'MAIL': '/var/mail/cltbld', 18:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:37 INFO - 'MOZ_NO_REMOTE': '1', 18:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:37 INFO - 'NO_EM_RESTART': '1', 18:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:37 INFO - 'PWD': '/builds/slave/test', 18:01:37 INFO - 'SHELL': '/bin/bash', 18:01:37 INFO - 'SHLVL': '1', 18:01:37 INFO - 'TERM': 'linux', 18:01:37 INFO - 'TMOUT': '86400', 18:01:37 INFO - 'USER': 'cltbld', 18:01:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:37 INFO - '_': '/tools/buildbot/bin/python'} 18:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:37 INFO - Running setup.py (path:/tmp/pip-2tkKt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:37 INFO - Running setup.py (path:/tmp/pip-0H8mRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:37 INFO - Running setup.py (path:/tmp/pip-9btwHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:37 INFO - Running setup.py (path:/tmp/pip-13VpFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:37 INFO - Running setup.py (path:/tmp/pip-0y5i_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:37 INFO - Running setup.py (path:/tmp/pip-MYc6WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:37 INFO - Running setup.py (path:/tmp/pip-OjNLH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:37 INFO - Running setup.py (path:/tmp/pip-bDfewQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:37 INFO - Running setup.py (path:/tmp/pip-hp7gPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:37 INFO - Running setup.py (path:/tmp/pip-BQHIlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:37 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)) 18:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:37 INFO - Running setup.py (path:/tmp/pip-kbP9h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:38 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)) 18:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:38 INFO - Running setup.py (path:/tmp/pip-gd0jB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:38 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)) 18:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:38 INFO - Running setup.py (path:/tmp/pip-XTwXYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:38 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)) 18:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:38 INFO - Running setup.py (path:/tmp/pip-c1U5Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:38 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)) 18:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:38 INFO - Running setup.py (path:/tmp/pip-_nmtd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:38 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)) 18:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:38 INFO - Running setup.py (path:/tmp/pip-XFhUv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:38 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)) 18:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:38 INFO - Running setup.py (path:/tmp/pip-T2oxVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:38 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)) 18:01:38 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)) 18:01:38 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)) 18:01:38 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)) 18:01:38 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)) 18:01:38 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)) 18:01:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:38 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 18:01:38 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 18:01:38 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 18:01:38 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 18:01:38 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 18:01:38 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 18:01:40 INFO - Downloading blessings-1.6.tar.gz 18:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:01:40 INFO - Installing collected packages: blessings 18:01:40 INFO - Running setup.py install for blessings 18:01:40 INFO - Successfully installed blessings 18:01:40 INFO - Cleaning up... 18:01:40 INFO - Return code: 0 18:01:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:01:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:40 INFO - Reading from file tmpfile_stdout 18:01:40 INFO - Current package versions: 18:01:40 INFO - argparse == 1.2.1 18:01:40 INFO - blessings == 1.6 18:01:40 INFO - blobuploader == 1.2.4 18:01:40 INFO - docopt == 0.6.1 18:01:40 INFO - functools32 == 3.2.3-2 18:01:40 INFO - jsonschema == 2.5.1 18:01:40 INFO - manifestparser == 1.1 18:01:40 INFO - mozInstall == 1.12 18:01:40 INFO - mozcrash == 0.17 18:01:40 INFO - mozdebug == 0.1 18:01:40 INFO - mozdevice == 0.48 18:01:40 INFO - mozfile == 1.2 18:01:40 INFO - mozhttpd == 0.7 18:01:40 INFO - mozinfo == 0.9 18:01:40 INFO - mozleak == 0.1 18:01:40 INFO - mozlog == 3.3 18:01:40 INFO - moznetwork == 0.27 18:01:40 INFO - mozprocess == 0.23 18:01:40 INFO - mozprofile == 0.28 18:01:40 INFO - mozrunner == 6.12 18:01:40 INFO - mozscreenshot == 0.1 18:01:40 INFO - mozsystemmonitor == 0.3 18:01:40 INFO - moztest == 0.7 18:01:40 INFO - mozversion == 1.4 18:01:40 INFO - psutil == 3.1.1 18:01:40 INFO - requests == 1.2.3 18:01:40 INFO - wsgiref == 0.1.2 18:01:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:40 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:40 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 18:01:40 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 18:01:40 INFO - Using env: {'DISPLAY': ':0', 18:01:40 INFO - 'HOME': '/home/cltbld', 18:01:40 INFO - 'LANG': 'en_US.UTF-8', 18:01:40 INFO - 'LANGUAGE': 'en_US:en', 18:01:40 INFO - 'LOGNAME': 'cltbld', 18:01:40 INFO - 'MAIL': '/var/mail/cltbld', 18:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:40 INFO - 'MOZ_NO_REMOTE': '1', 18:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:40 INFO - 'NO_EM_RESTART': '1', 18:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:40 INFO - 'PWD': '/builds/slave/test', 18:01:40 INFO - 'SHELL': '/bin/bash', 18:01:40 INFO - 'SHLVL': '1', 18:01:40 INFO - 'TERM': 'linux', 18:01:40 INFO - 'TMOUT': '86400', 18:01:40 INFO - 'USER': 'cltbld', 18:01:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:40 INFO - '_': '/tools/buildbot/bin/python'} 18:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 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)) 18:01:41 INFO - Cleaning up... 18:01:41 INFO - Return code: 0 18:01:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, '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': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', '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 18:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:01:41 INFO - Using env: {'DISPLAY': ':0', 18:01:41 INFO - 'HOME': '/home/cltbld', 18:01:41 INFO - 'LANG': 'en_US.UTF-8', 18:01:41 INFO - 'LANGUAGE': 'en_US:en', 18:01:41 INFO - 'LOGNAME': 'cltbld', 18:01:41 INFO - 'MAIL': '/var/mail/cltbld', 18:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:41 INFO - 'MOZ_NO_REMOTE': '1', 18:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:41 INFO - 'NO_EM_RESTART': '1', 18:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:41 INFO - 'PWD': '/builds/slave/test', 18:01:41 INFO - 'SHELL': '/bin/bash', 18:01:41 INFO - 'SHLVL': '1', 18:01:41 INFO - 'TERM': 'linux', 18:01:41 INFO - 'TMOUT': '86400', 18:01:41 INFO - 'USER': 'cltbld', 18:01:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:41 INFO - '_': '/tools/buildbot/bin/python'} 18:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:01:41 INFO - Cleaning up... 18:01:41 INFO - Return code: 0 18:01:41 INFO - Running post-action listener: _resource_record_post_action 18:01:41 INFO - Running post-action listener: _start_resource_monitoring 18:01:41 INFO - Starting resource monitoring. 18:01:41 INFO - [mozharness: 2016-07-26 01:01:41.318365Z] Finished create-virtualenv step (success) 18:01:41 INFO - [mozharness: 2016-07-26 01:01:41.318914Z] Running install step. 18:01:41 INFO - Running pre-action listener: _resource_record_pre_action 18:01:41 INFO - Running main action method: install 18:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:41 INFO - Reading from file tmpfile_stdout 18:01:41 INFO - Detecting whether we're running mozinstall >=1.0... 18:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:01:41 INFO - Reading from file tmpfile_stdout 18:01:41 INFO - Output received: 18:01:41 INFO - Usage: mozinstall [options] installer 18:01:41 INFO - Options: 18:01:41 INFO - -h, --help show this help message and exit 18:01:41 INFO - -d DEST, --destination=DEST 18:01:41 INFO - Directory to install application into. [default: 18:01:41 INFO - "/builds/slave/test"] 18:01:41 INFO - --app=APP Application being installed. [default: firefox] 18:01:41 INFO - mkdir: /builds/slave/test/build/application 18:01:41 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'] 18:01:41 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 18:01:58 INFO - Reading from file tmpfile_stdout 18:01:58 INFO - Output received: 18:01:58 INFO - /builds/slave/test/build/application/firefox/firefox 18:01:58 INFO - Running post-action listener: _resource_record_post_action 18:01:58 INFO - [mozharness: 2016-07-26 01:01:58.030659Z] Finished install step (success) 18:01:58 INFO - [mozharness: 2016-07-26 01:01:58.031000Z] Running run-tests step. 18:01:58 INFO - Running pre-action listener: _resource_record_pre_action 18:01:58 INFO - Running main action method: run_tests 18:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:58 INFO - Python 2.7.3 18:01:58 INFO - Return code: 0 18:01:58 INFO - grabbing minidump binary from tooltool 18:01: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')]} 18:01:58 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 0x1f4a570>, '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 0x1f4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:58 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 18:01:58 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 18:01:58 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 18:01:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:58 INFO - Return code: 0 18:01:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:01:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:01:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:58 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/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 18:01:58 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/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 18:01:58 INFO - Using env: {'DISPLAY': ':0', 18:01:58 INFO - 'HOME': '/home/cltbld', 18:01:58 INFO - 'LANG': 'en_US.UTF-8', 18:01:58 INFO - 'LANGUAGE': 'en_US:en', 18:01:58 INFO - 'LOGNAME': 'cltbld', 18:01:58 INFO - 'MAIL': '/var/mail/cltbld', 18:01:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:58 INFO - 'MOZ_NO_REMOTE': '1', 18:01:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:58 INFO - 'NO_EM_RESTART': '1', 18:01:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:58 INFO - 'PWD': '/builds/slave/test', 18:01:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:58 INFO - 'SHELL': '/bin/bash', 18:01:58 INFO - 'SHLVL': '1', 18:01:58 INFO - 'TERM': 'linux', 18:01:58 INFO - 'TMOUT': '86400', 18:01:58 INFO - 'USER': 'cltbld', 18:01:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1469494190.594950-198813963', 18:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:58 INFO - '_': '/tools/buildbot/bin/python'} 18:01:58 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/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 18:01:58 INFO - mozversion application_buildid: 20160725171403 18:01:58 INFO - mozversion application_changeset: 4b60c69db493e32e87f89376cb0e918712d64b44 18:01:58 INFO - mozversion application_display_name: Nightly 18:01:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:58 INFO - mozversion application_name: Firefox 18:01:58 INFO - mozversion application_remotingname: firefox 18:01:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:01:58 INFO - mozversion application_vendor: Mozilla 18:01:58 INFO - mozversion application_version: 50.0a1 18:01:58 INFO - mozversion platform_buildid: 20160725171403 18:01:58 INFO - mozversion platform_changeset: 4b60c69db493e32e87f89376cb0e918712d64b44 18:01:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:01:58 INFO - mozversion platform_version: 50.0a1 18:01:58 INFO - using testdate: 1469494918 18:01:58 INFO - actual date: 1469494918 18:01:58 INFO - starting webserver on 'localhost:59695' 18:01:58 INFO - SUITE-START | Running 2 tests 18:01:58 INFO - TEST-START | dromaeo_css 18:01:58 INFO - operating with platform_type : linux_ 18:01:58 INFO - Initialising browser for dromaeo_css test... 18:01:58 INFO - TEST-INFO | started process 21605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgLgOK4/profile http://localhost:59695/getInfo.html) 18:02:01 INFO - PROCESS | 21605 | JavaScript error: , line 0: uncaught exception: undefined 18:02:03 INFO - PROCESS | 21605 | __metrics Screen width/height:1600/1200 18:02:03 INFO - PROCESS | 21605 | colorDepth:24 18:02:03 INFO - PROCESS | 21605 | Browser inner width/height: 1024/697 18:02:03 INFO - PROCESS | 21605 | __metrics 18:02:04 ERROR - PROCESS | 21605 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 18:02:04 INFO - TEST-INFO | 21605: exit 0 18:02:04 INFO - Browser initialized. 18:02:04 INFO - Running cycle 1/1 for dromaeo_css test... 18:02:04 INFO - TEST-INFO | started process 21726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgLgOK4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:16 INFO - PROCESS | 21726 | RSS: Main: 165556224 18:02:16 INFO - PROCESS | 21726 | 18:03:06 INFO - PROCESS | 21726 | 1469494986560 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] 18:05:19 INFO - PROCESS | 21726 | Cycle 1(1): loaded http://localhost:59695/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59695/tests/dromaeo/cssquery-ext.html) 18:05:20 INFO - PROCESS | 21726 | RSS: Main: 167456768 18:05:20 INFO - PROCESS | 21726 | 18:08:22 INFO - PROCESS | 21726 | Cycle 1(1): loaded http://localhost:59695/tests/dromaeo/cssquery-ext.html (next: http://localhost:59695/tests/dromaeo/cssquery-jquery.html) 18:08:23 INFO - PROCESS | 21726 | RSS: Main: 167309312 18:08:23 INFO - PROCESS | 21726 | 18:11:25 INFO - PROCESS | 21726 | Cycle 1(1): loaded http://localhost:59695/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59695/tests/dromaeo/cssquery-mootools.html) 18:11:26 INFO - PROCESS | 21726 | RSS: Main: 171192320 18:11:26 INFO - PROCESS | 21726 | 18:14:28 INFO - PROCESS | 21726 | Cycle 1(1): loaded http://localhost:59695/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59695/tests/dromaeo/cssquery-prototype.html) 18:14:28 INFO - PROCESS | 21726 | RSS: Main: 165105664 18:14:28 INFO - PROCESS | 21726 | 18:17:31 INFO - PROCESS | 21726 | Cycle 1(1): loaded http://localhost:59695/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59695/tests/dromaeo/cssquery-yui.html) 18:17:32 INFO - PROCESS | 21726 | RSS: Main: 167235584 18:17:32 INFO - PROCESS | 21726 | 18:20:34 INFO - PROCESS | 21726 | Cycle 1(1): loaded http://localhost:59695/tests/dromaeo/cssquery-yui.html (next: http://localhost:59695/tests/dromaeo/cssquery-dojo.html) 18:20:35 INFO - PROCESS | 21726 | RSS: Main: 170516480 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | __start_tp_report 18:20:35 INFO - PROCESS | 21726 | _x_x_mozilla_page_load 18:20:35 INFO - PROCESS | 21726 | _x_x_mozilla_page_load_details 18:20:35 INFO - PROCESS | 21726 | |i|pagename|runs| 18:20:35 INFO - PROCESS | 21726 | |0;dojo.html;2684.0337478507745;2689.6368990186324;2716.2530304166353;2718.1301983365324;2740.3286194882244;4703.882402939928;4883.877903052421;4896.63275254356;4907.239377896422;4935.629827762914;4800.111979283826;4833.540813622709;4851.902961940759;4860.951390486094;4915.582175515076;4466.2184117779425;4484.663650226246;4486.932696009562;4571.200039993005;4594.104149690812;4521.502634710179;4525.502194758574;4544.318352247156;4551.317302404649;4572.039871626946;4334.219840428722;4372.978135109304;4377.212101821671;4418.64650827933;4445.488768791598;4446.4886538047895;4455.977720111411;4456.844010459651;4483.417155769762;4490.955090449086;4377.277749171383;4399.912001759979;4421.579949904753;4443.888902777424;4471.9776401118115;4709.1288111699105;4751.97832466018;4788.257820037899;4807.471178170398;4819.204831202847;5246.422893481714;5247.632665713401;5251.212318152269;5262;5269.314989051437;5262.394824595182;5271.532824869157;5283.128283833163;5287.973560132214;5331.093714068579;4736.739479328601;4839.903201935942;4882.7558622068755;4889.046635906036;4898.191798353303;5414.485623865727;5427.0773968425465;5433.510984011458;5475.09660905954;5488;5164.948350516522;5171.198464238049;5192.4807519248525;5211.348581427322;5234.895302093937;5025.472325405853;5141.717205553656;5216.58267338612;5261.657992230569;5293.470652934676;5205.193195054772;5205.531502164823;5207;5214.504622060898;5239.1355426354985;5164.845054648366;5191.6884986900905;5205.24523944026;5207.973960130251;5269.051570717308;4254.638355739797;4314.697971142053;4347.673924455678;4348.108637729258;4365.454318210223;3762.924741505209;3781.5084039074745;3785.356489396809;3807.0672685192303;3845.9230815383535;4471.23988921884;4474.88127968008;4489;4502.57225563571;4521.344405061313;4976.850694479172;5079.060373830853;5093.8726531836255;5137.460566640524;5175.560077393388;4404.097160082176;4404.207242696345;4434.82260709568;4438.134563760101;4467.039586488921;4589.242774942164;4590.219662657356;4606.907861842811;4638.721676699409;4651.37206477128;4778.761061946958;4884.975575122102;4902.779374928136;4903.872109414926;4941.50584941503;5250.97374513125;5276.894462110659;5289.709066001406;5306.602004849575;5319.547838433777;4906.2640603909695;4939.925901111558;4951.8266860659705;4954.108260513142;4979.701217926936;4955.058538877602;5078.21287700407;5107.87230319245;5144.382674078985;5220.7650655721345;5172.301739265151;5174.120399532164;5198.870028249324;5201.505856943584;5259.237410575522;5010.724410157476;5010.849674509771;5023.673461225008;5050.267711181785;5075.695458272516;4922.901541969212;4991.47589503097;5007.774650140679;5044.066847633199;5045.823396181116;4949.727764972961;4967.9006419870675;4974.179260422135;5004.649674522749;5036.521530454601;5075.3148324975655;5123.1034568949535;5141.53726164647;5143.92284115731;5186;4792.496787837227;4928.236123400879;4973.129702302155;4988.55103040728;5005.274235235943 18:20:35 INFO - PROCESS | 21726 | |1;ext.html;548.0737553534526;559.3818830192636;561.1190431023296;565.8670212500065;589.1192666962891;34051.318973620546;38355.80822095893;38518.037049073755;38519.80740096299;38580;39296.80351598238;39837.40243896336;40027.59972400275;40055.79972100143;40107.197856042934;7659.502132361406;7777.105632852238;7784.104827944802;7784.727534536292;7791.961040194819;7641.426892983049;7654.387648988068;7727.420443466763;7747.883781743279;7756.961215193916;7772.106207786092;7772.222777722211;7799.649015794274;7805.5706936118495;7821.256980586863;7725.5364678119495;7757.5733334666575;7775.922240777576;7778.416618753616;7782.766517004499;7719.073711154641;7719.266669666373;7728.420368472387;7733.381329493627;7763.805904852367;37171.62828371736;37859;37919.62080379216;37948.24103517914;38040.42939355912;2442.3771938155655;2947.8673459694364;3054.511278195478;3065.065155127685;3418.6923176913947;27745.306367340778;28090.85954570214;30547.358258645298;30976.690233097605;31428.52857207144;3226.4998925166637;3273.9836300818583;3278.1476816027766;3355.8489867956;3405.6594340565994;279678;279944;281482;282420;282718.5864070687;56450.71774641183;57245.706572007264;57450.425495745345;57537.42462575321;57639;34182.48726269108;35044.12389690278;35227.82386088104;36984;37035;15785.68428631421;15953.760693589606;15989.28048237832;15997.600059998593;16092;11574.611046674285;11676.70808229801;11708.88291117095;11718.472668729757;11722;19210.231590736494;19218.903905480383;19424.90287548553;19425.4172374829;19454.319098831475;7156.212816590171;7193.856122877513;7373.631318434057;7405.111386633638;7498.737544185928;798.5807451088109;925.3938670171049;928.5171710710392;944.4380593546829;956.3114557518576;27625.585616215772;28126;28277.71722282792;28344.433111337657;28821;871.4858233642182;916.4913473022403;946.4652471353663;986.7779749556292;1035.7928414317166;14751.262436878113;14923.850761492464;15044.849551504563;15393.23033848303;15428.997115187476;395847;398925;399898;399918;400810;50827.7458612712;51422.22866657003;51676;51706.48293517092;51988;1164.0629293418879;1174.7885380631396;1196.0670676872053;1214.878512148778;1215.817627355886;26273;26880.865595671898;27842.860785695942;27981.720182798726;28159.15522534327;37433.25133497369;38074.8096259528;38404.615953840104;38419.231615368095;38419.80790096032;275264;277056;277331;279333;280450;23935.521289573764;24099.879500602387;24331.148409805573;24345.513089737753;24346;42391;42557;42720;42797;42878.571214287454;34777.47833782546;36239.45640815337;36593.81703091467;37039.629603703615;37206.6279337214;36296.27407451889;36933.81533092317;37031.8148409267;40151.59848401479;40840.59159408368;34888;36543;37529.62470375261;37797.62202378051;37846.81076594599;37275.62724372721;37937.4309385365;38149.23701525899;38248.808755956044;38572.6142738569;29293.26766830846;29830.25424364408;30155.547666784576;30880.691193087783;31000.84499577578 18:20:35 INFO - PROCESS | 21726 | |2;jquery.html;364.81576803714137;372.1644907183374;377.97732136071835;383.3674437178657;391.8197629090618;11735.237209581372;12247.510099596017;16867.91566042171;16955.152242387892;17098.059606721625;15824.76262856058;17033.232057523317;17109.31562737489;17125.14374281287;17231.138443077827;4986.326845875806;5162.948370516285;5171.870703232412;5191.091558977183;5210.5310522053005;5044.82343117991;5059.620528460362;5091.516305950929;5095.133827249377;5095.235714642796;5069.797208111671;5327.668082979255;5364.7317634118335;5381.946180538203;5406.675599464025;5355.732213389334;5392.541633961118;5844.298684157929;5944.405559444064;5955.553333500005;5243.2659427680155;5269.130593452076;5288.471152884719;5292.841214763564;5318.095923692981;19958.900205498878;20024.399268021836;20318.898405507876;20361.694574581394;20635.89682051595;1854.4900152458047;1898.364048043907;1928.7781905080956;2069.968950465729;2312.9476088379747;9126.26989840811;9210.769730756718;11987.340696261703;12455.813162802566;13520;1671.6907372136072;1710.4868539438244;1730.832576385212;1744.0756399108493;1804.6300508395748;51133.48866511325;79608.99999999942;79904.60047699782;81601.92502583463;82224.58887705582;16181.676366472604;16620.83379166217;17003;17064.914675426542;17088;28452.573211401846;28540.571891421645;28576.71386289092;28629.28426789347;28809.279768005967;9264.583093760797;9455.810883782286;9568.61725530985;9778.65774697882;9808.705738827846;7919.84160316802;7921.1682773307975;7949.682012719427;8005.359571234288;8193.09875913649;8288.254057134887;8490.745277641558;8512.276456501268;8631.784205394915;8692.783340248323;3215.340855124694;3320.8505617247283;3395.1094850434474;3433.296174284266;3536.929261414757;773.2615352338615;827.4497459189691;874.2001069021901;877.3989816975393;934.6541779541614;16000.679986400439;16591.41930032443;17106.743398849027;17442.738358924627;17517.386891458736;857.9442336248123;861.573521107056;884.6461415433878;915.3866909170871;930.4277869110448;8967.103289671111;9428.952855235817;9480.288978326653;9555.856662150074;9700.223982081416;386872;390615;391263;393724;394623;46273.768631157305;50596.241056384184;76240.23759762332;76342.61828690932;83437.58281208554;899.3839220134229;909.6406919266852;920.9723708288763;924.7456949338851;928.6471140966389;13975.860241397455;15129.243537822844;15294.311755970786;15402.15288159162;15671.373145074069;37949.81025094857;38346.233075338896;38405.23189536138;38505.422418664304;38653.613463866124;48113.75943120262;49784.50215497943;53139.734301328244;53650.46349536454;54593.1811022827;7664.425168112302;7736.2650548197835;7745.148033716174;7806.180351063056;8231.670733170606;8979.595918183828;11327.271550930433;11811.232269902428;11830.526778928746;12083.697907552381;9394.812103758024;9654.372465789702;9733.610655573697;10053.19574434058;10148.898511015092;9648.179904708179;10118.949405252926;10367.222458315808;10405.84391234117;10680.305780124267;9517.333786635147;9889.604415823287;10225.693229203136;10356.067953884187;10808.297460665031;7416.8887466686965;7887.84224315499;7940.404469664682;8025.638846252049;8363.121872203574;9239.39943903644;9516.095970882756;9813.705588832347;10088.293819432569;10525.78948421012 18:20:35 INFO - PROCESS | 21726 | |3;mootools.html;1374.086232655284;1427.357689039932;1511.8866085043617;1679.4625719769679;1722.4832550234926;6807.6596170191415;7398.6670599823;7701.6919323227075;8217.178282171788;8231.094579596247;7565.432592555553;7828.921710782891;7850.6074696265105;7854.293113619773;7869.134395216536;2211.5355775287167;2247.224707475918;2251.2120757734824;2254.222293308806;2257.661350797377;2156.676498525218;2177.9019944102474;2199.516106456577;2222.677711731806;2229.7101376820992;2189.0696454006984;2192.6601376786543;2197.3517812245427;2204.7464541577683;2245.079517397867;2178.1287485005964;2181.2474696229774;2196.3081629286803;2196.714427124464;2210.049678638185;2161.718976533041;2182.0399024429357;2183.585118827418;2189.6058709432295;2193.813525850289;7919.524828510308;8005.599720013976;8006.799830004238;8006.879896801553;8033.1163572007035;4667.393238878958;4766.475687674353;4822.445418776851;4822.517748225185;4830.855074347775;2947.9318540414306;3063.0855715178013;3088.4286407014774;3100.3489267253904;3114.68853114689;966.3622009473784;973.2214228617078;998.4408731110601;1006.6023920551414;1018.6689325969089;11293.20947533673;11343.546258149665;11386.373749443777;11429.114196157623;11451.59919402817;4109.671226301889;4352.564743525622;4460.219461594273;4468.754218518013;4496.0558282760985;9548.283878708986;9606.519674016272;9621.807563848684;9622.951885240669;9629.903700963041;4747.098051370229;4757.714537127784;4761.047790441926;4780.995990841962;4791.281307803857;3674.11821162919;4129.731567448106;4287.399764033038;4393.912121757547;4418.072204836956;3718.7396882217986;3722.7766334020043;3842.1355195080882;3856.382978723391;3893.7469064511283;1221.5175005872632;1226.3500344817262;1227.7360367521026;1250.143651598658;1254.1597129922973;718.9532680375759;829.4359835312046;838.2162677896187;849.7705619482705;856.267890953226;5284.286621306152;5322.33470816148;5438.673679579238;5451.809186678447;5500.4224556420995;409.06528582189554;412.9236091323055;420.6235419299771;421.58473903205316;423.1072437157595;3629.8366573504254;3740.6259374062374;3786.2427514497213;3812.313783518993;3820.3123437781464;9597.472139032281;9885.703428897144;9943.651972180938;9993;10046.04562566555;9627.208109648263;9832.754181145528;9862.852057219005;9945.502724863727;9964.601415943425;6902.757503649291;7031.8945215821805;7129.108861392326;7166.319199676022;7178.4257259420165;5419.918701219563;5421.132618780976;5449.209864569694;5455.672659640434;5535.474129957647;8972.730818075468;9089;9115.27077833785;9197.586108624993;9282.071792820663;9134.908650913405;9226.630934762803;9288.72133835986;9299.302552308469;9441.669541566012;5735.426457354231;6512.5766825156215;6696.397324240842;7069.434445244471;7112.217656057933;7477.476576639583;7632.3512501438;7679.616019199129;7684.731034413769;7706.576138312223;6653.168353955755;6769.9661501694145;6790.72837086511;6811.114555107804;6935.687894044881;6460.612363258219;6564.671766411565;6628.171478565179;6634.203895532567;6760.884454065024;6152.815415537541;6179.6910154493;6180.042093475518;6180.907286390798;6186.443220110212;4452.154090722753;4531.660125490667;4622.953770462387;4670.953290467051;4700.694454860423;4582.106489234568;4671.696339737906;4700.318453824245;4716.363290955677;4821.156297647968 18:20:35 INFO - PROCESS | 21726 | |4;prototype.html;298.19487384063024;301.65761860288575;311.0450915688836;314.0719174838353;314.7843727046973;4905.33777939978;4978.975105124474;4981.775820088095;5088.669236499634;5119.283300337951;4993.651714037208;5001;5008.2738002989545;5023.497650234975;5036.632782592176;3952.4664170336923;3956.4460975463458;3958.5447673517483;3967.3453880109746;3969.28552860485;3871.1483473635894;3928.666063384616;3958.188571342868;3972.463717398143;3980.1641655252433;3893.4159876018684;3926.1362500249897;3928.7642741435607;3929.332013557688;3937.3503371943593;3903.9354107025847;3911.4915061042166;3916.0992971616547;3946.1910308386714;3947.210557888434;3489.7382696297877;3499.720022398202;3500.6674365935196;3512.648735126467;3522.189896323834;4662.487126416091;4940.308356830046;4963.759060234941;4985.651004429691;5005.599552035828;4456.442944631921;4458.487273963503;4468.82124715011;4473.284274516094;4475.39582156408;5239.528442440161;5264.236685680593;5292.179712144623;5295.973520132413;5299.364076310829;3660.853565857389;3696.316181506403;3718.721095917817;3732.7976493868746;3758.981205093957;5461.808836690737;5470.64440811346;5478.698671573062;5498.202760599691;5516.641418307838;3786.088025547081;3786.2238241160494;3792.388235000114;3796.126890815128;3796.1838204786104;3768.5477742671055;3842.634949679776;3845.384738441836;3851.4030325299623;3858.6334298241622;4380.685794261709;4400.163968845909;4403.304727679866;4405.876501492099;4441.200583894865;5297.576193904479;5324.9733751331;5329.786808527616;5341.145416733304;5344.75948582307;1240.838690970168;1301.7071158989152;1337.9598612041655;1339.069346803962;1348.8381394232754;892.3352102683542;908.1191244492964;923.5936188077225;929.5631053404888;934.5187228577288;4583.816647334136;4585.587297143273;4596.333531637893;4610.631149508032;4627.120847039052;5346.198070289488;5366.892662146814;5378.91931621026;5432.429594892558;5439.428859969726;4459.554044595515;4553.408056952575;4574.931376029363;4576.290674945389;4624.722516648944;2532.696076470835;2551.668283123182;2561.4877024595157;2573.4081161332624;2582.496413199408;4569.497355290915;4590.71763688964;4595.310703394518;4602.217623004098;4607.76961151941;4573.8274319697875;4881.51184881509;4894.042383046739;4902.828401005948;4936.950630493721;4455.910881782346;4474.373587697725;4484.798184081724;4492.820287188476;4495.527969563149;4765.404324459442;4765.928511072406;4780.251355470548;4786.784594693317;4809.134355815987;4690.671652984258;4756.192646794196;4764.2615394613895;4773.284007398918;4799.736014519095;4766.308885211694;5140.742962851918;5155.716435596079;5161.561267292323;5169.974150129226;3817.370133927982;3875.8643447479203;3875.87599596114;3891.703894702139;3912.2175564886566;5088.59609268506;5532.1425179097305;5539.307586551681;5543.1962365455975;5547.528460080777;5015.899682006267;5261.080100544082;5261.579073674174;5274.8945021100135;5279.39286982002;5280.287161233338;5290.619221350331;5292.682439053669;5300.9734951325;5304.825021741068;4962.925556116589;5126.359205099363;5143.665661731976;5177.948220517746;5194.558462530727;5247.347085668002;5353.223782551586;5359.169328754049;5369.597280203922;5373.838784836461;5213.478652134756;5227.451117632594;5249.396319423316;5262.552683021833;5278.89442211146 18:20:35 INFO - PROCESS | 21726 | |5;yui.html;598.9371116032817;604.1330690459195;624.378743150565;683.402023229674;696.8884978403453;12345.691357716061;12359.258444493315;12962.611121666341;13039.282839443827;13041.934790326048;12016.339101349422;12034.518619255241;12098.637040888787;12123.575674851381;12272.20230685005;735.4263674334014;747.4692967992731;755.9697612095537;756.6065645864147;757.0574634579956;614.0328981853576;734.5629350536449;753.4838635534649;759.036024249206;767.1982777996978;806.0408114343912;806.0689903161857;809.5952023988006;811.8051667599792;814.2590242878981;796.366888323784;804.5655346113092;804.5896592737716;805.0299389235956;806.4395245304545;583;584.4418580255888;590.5570821883588;590.6190507122925;590.9113632955048;12692.682682932907;12701;12701.301428421433;12708.237505749685;12732.04509661779;11500.654980350602;11677.883221167764;12121;12202;12569.622911312676;10103.494825258707;10208.591656333738;10245.334053286588;10309.845352319646;10487.37075775456;3201.27971206479;3224.193951512122;3231.628362738292;3234.7735658503916;3405.7445691572984;61584.38415615831;62834.37165628331;63079;63514.364856351305;63528.682356587924;8942.105789421006;9082.091790820865;9381.577828997712;9633.566489507988;9694.418334899929;19647.410577682407;19650;19709.11308991099;19748.802511974984;20064.59870802576;6479.481641468671;6536.207805644827;6696.59820410777;6746.696398661974;6824.078749368771;3696.4085746280466;3697.574778900407;3721.218544105768;3730.235301763132;3740.569834469071;2778.1804367711575;2867.8709458074436;2918.1829087855435;2921.3426978929997;2940.867660955262;484.94180698316427;493.2133247470279;493.7284493528545;496.3720893070269;508.6261597725669;486.5839707050421;514.5960421069442;531.455258360184;536.3269097282885;542.378976072395;6408.807735767934;6759.526833121733;6900.5163889762935;7005.334493223238;7341.375983041501;462.8958484340996;513.2942204468856;532.7735712322248;533.6131304803986;535.3923297057789;3176.1900715317447;3353.4299169141304;3424.74314426419;3472.8437220325145;3526.894193174209;90432;95026.52486737522;97114.5144274274;97301.51349243209;99776.50111749394;48062;48461;48875.75562122238;48938.510614894105;79389;70250;75172;75282.24717752862;76208.23791762123;77317.61341193259;6494.350564943468;6509.641969691523;6537.182852143482;6645.1361323027695;6882.7591034313555;42992.78503607587;44722.77638611786;44838.775806120764;45255.7737211325;45586.54413455823;47037.529624704686;47386.763066184445;61276.38723612707;63320.683396582725;72108;10662.306950048222;10950.507227174638;11021.118310535297;11142.721431964266;11706.590269340531;11450.599229026944;11558.537658493902;11598;11678.941605291919;11993.760124797629;9925.751856203653;10077.496125193858;10375;10409.47952602382;10712.196585256293;10114.494275286354;10299.433531155859;10495.580176792842;10657.094146997591;10751.892481075089;10064.798704025732;10247.231457640855;10346.482675866328;10359.05881178743;10525.684229473129;8545.615447304763;8551.8717219243;8589.14108589136;8673.913260867563;9129.45223286605;8818.735437936872;8932.508712020901;9402.905970940203;9406.623735050522;9467.437872751194 18:20:35 INFO - PROCESS | 21726 | __end_tp_report 18:20:35 INFO - PROCESS | 21726 | __start_cc_report 18:20:35 INFO - PROCESS | 21726 | _x_x_mozilla_cycle_collect,357 18:20:35 INFO - PROCESS | 21726 | __end_cc_report 18:20:35 INFO - PROCESS | 21726 | __startTimestamp1469496035122__endTimestamp 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | ------- Summary: start ------- 18:20:35 INFO - PROCESS | 21726 | Number of tests: 6 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | [#0] dojo.html Cycles:165 Average:4801.72 Median:4935.63 stddev:520.35 (10.5%) stddev-sans-first:494.72 18:20:35 INFO - PROCESS | 21726 | Values: 2684.0 2689.6 2716.3 2718.1 2740.3 4703.9 4883.9 4896.6 4907.2 4935.6 4800.1 4833.5 4851.9 4861.0 4915.6 4466.2 4484.7 4486.9 4571.2 4594.1 4521.5 4525.5 4544.3 4551.3 4572.0 4334.2 4373.0 4377.2 4418.6 4445.5 4446.5 4456.0 4456.8 4483.4 4491.0 4377.3 4399.9 4421.6 4443.9 4472.0 4709.1 4752.0 4788.3 4807.5 4819.2 5246.4 5247.6 5251.2 5262.0 5269.3 5262.4 5271.5 5283.1 5288.0 5331.1 4736.7 4839.9 4882.8 4889.0 4898.2 5414.5 5427.1 5433.5 5475.1 5488.0 5164.9 5171.2 5192.5 5211.3 5234.9 5025.5 5141.7 5216.6 5261.7 5293.5 5205.2 5205.5 5207.0 5214.5 5239.1 5164.8 5191.7 5205.2 5208.0 5269.1 4254.6 4314.7 4347.7 4348.1 4365.5 3762.9 3781.5 3785.4 3807.1 3845.9 4471.2 4474.9 4489.0 4502.6 4521.3 4976.9 5079.1 5093.9 5137.5 5175.6 4404.1 4404.2 4434.8 4438.1 4467.0 4589.2 4590.2 4606.9 4638.7 4651.4 4778.8 4885.0 4902.8 4903.9 4941.5 5251.0 5276.9 5289.7 5306.6 5319.5 4906.3 4939.9 4951.8 4954.1 4979.7 4955.1 5078.2 5107.9 5144.4 5220.8 5172.3 5174.1 5198.9 5201.5 5259.2 5010.7 5010.8 5023.7 5050.3 5075.7 4922.9 4991.5 5007.8 5044.1 5045.8 4949.7 4967.9 4974.2 5004.6 5036.5 5075.3 5123.1 5141.5 5143.9 5186.0 4792.5 4928.2 4973.1 4988.6 5005.3 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | [#1] ext.html Cycles:180 Average:47397.70 Median:37663.62 stddev:85310.99 (226.5%) stddev-sans-first:85477.79 18:20:35 INFO - PROCESS | 21726 | Values: 548.1 559.4 561.1 565.9 589.1 34051.3 38355.8 38518.0 38519.8 38580.0 39296.8 39837.4 40027.6 40055.8 40107.2 7659.5 7777.1 7784.1 7784.7 7792.0 7641.4 7654.4 7727.4 7747.9 7757.0 7772.1 7772.2 7799.6 7805.6 7821.3 7725.5 7757.6 7775.9 7778.4 7782.8 7719.1 7719.3 7728.4 7733.4 7763.8 37171.6 37859.0 37919.6 37948.2 38040.4 2442.4 2947.9 3054.5 3065.1 3418.7 27745.3 28090.9 30547.4 30976.7 31428.5 3226.5 3274.0 3278.1 3355.8 3405.7 279678.0 279944.0 281482.0 282420.0 282718.6 56450.7 57245.7 57450.4 57537.4 57639.0 34182.5 35044.1 35227.8 36984.0 37035.0 15785.7 15953.8 15989.3 15997.6 16092.0 11574.6 11676.7 11708.9 11718.5 11722.0 19210.2 19218.9 19424.9 19425.4 19454.3 7156.2 7193.9 7373.6 7405.1 7498.7 798.6 925.4 928.5 944.4 956.3 27625.6 28126.0 28277.7 28344.4 28821.0 871.5 916.5 946.5 986.8 1035.8 14751.3 14923.9 15044.8 15393.2 15429.0 395847.0 398925.0 399898.0 399918.0 400810.0 50827.7 51422.2 51676.0 51706.5 51988.0 1164.1 1174.8 1196.1 1214.9 1215.8 26273.0 26880.9 27842.9 27981.7 28159.2 37433.3 38074.8 38404.6 38419.2 38419.8 275264.0 277056.0 277331.0 279333.0 280450.0 23935.5 24099.9 24331.1 24345.5 24346.0 42391.0 42557.0 42720.0 42797.0 42878.6 34777.5 36239.5 36593.8 37039.6 37206.6 36296.3 36933.8 37031.8 40151.6 40840.6 34888.0 36543.0 37529.6 37797.6 37846.8 37275.6 37937.4 38149.2 38248.8 38572.6 29293.3 29830.3 30155.5 30880.7 31000.8 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | [#2] jquery.html Cycles:180 Average:25086.56 Median:5080.66 stddev:64501.35 (1269.5%) stddev-sans-first:64655.58 18:20:35 INFO - PROCESS | 21726 | Values: 364.8 372.2 378.0 383.4 391.8 11735.2 12247.5 16867.9 16955.2 17098.1 15824.8 17033.2 17109.3 17125.1 17231.1 4986.3 5162.9 5171.9 5191.1 5210.5 5044.8 5059.6 5091.5 5095.1 5095.2 5069.8 5327.7 5364.7 5381.9 5406.7 5355.7 5392.5 5844.3 5944.4 5955.6 5243.3 5269.1 5288.5 5292.8 5318.1 19958.9 20024.4 20318.9 20361.7 20635.9 1854.5 1898.4 1928.8 2070.0 2312.9 9126.3 9210.8 11987.3 12455.8 13520.0 1671.7 1710.5 1730.8 1744.1 1804.6 51133.5 79609.0 79904.6 81601.9 82224.6 16181.7 16620.8 17003.0 17064.9 17088.0 28452.6 28540.6 28576.7 28629.3 28809.3 9264.6 9455.8 9568.6 9778.7 9808.7 7919.8 7921.2 7949.7 8005.4 8193.1 8288.3 8490.7 8512.3 8631.8 8692.8 3215.3 3320.9 3395.1 3433.3 3536.9 773.3 827.4 874.2 877.4 934.7 16000.7 16591.4 17106.7 17442.7 17517.4 857.9 861.6 884.6 915.4 930.4 8967.1 9429.0 9480.3 9555.9 9700.2 386872.0 390615.0 391263.0 393724.0 394623.0 46273.8 50596.2 76240.2 76342.6 83437.6 899.4 909.6 921.0 924.7 928.6 13975.9 15129.2 15294.3 15402.2 15671.4 37949.8 38346.2 38405.2 38505.4 38653.6 48113.8 49784.5 53139.7 53650.5 54593.2 7664.4 7736.3 7745.1 7806.2 8231.7 8979.6 11327.3 11811.2 11830.5 12083.7 9394.8 9654.4 9733.6 10053.2 10148.9 9648.2 10118.9 10367.2 10405.8 10680.3 9517.3 9889.6 10225.7 10356.1 10808.3 7416.9 7887.8 7940.4 8025.6 8363.1 9239.4 9516.1 9813.7 10088.3 10525.8 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | [#3] mootools.html Cycles:180 Average:5234.19 Median:4822.48 stddev:2974.87 (61.7%) stddev-sans-first:2969.07 18:20:35 INFO - PROCESS | 21726 | Values: 1374.1 1427.4 1511.9 1679.5 1722.5 6807.7 7398.7 7701.7 8217.2 8231.1 7565.4 7828.9 7850.6 7854.3 7869.1 2211.5 2247.2 2251.2 2254.2 2257.7 2156.7 2177.9 2199.5 2222.7 2229.7 2189.1 2192.7 2197.4 2204.7 2245.1 2178.1 2181.2 2196.3 2196.7 2210.0 2161.7 2182.0 2183.6 2189.6 2193.8 7919.5 8005.6 8006.8 8006.9 8033.1 4667.4 4766.5 4822.4 4822.5 4830.9 2947.9 3063.1 3088.4 3100.3 3114.7 966.4 973.2 998.4 1006.6 1018.7 11293.2 11343.5 11386.4 11429.1 11451.6 4109.7 4352.6 4460.2 4468.8 4496.1 9548.3 9606.5 9621.8 9623.0 9629.9 4747.1 4757.7 4761.0 4781.0 4791.3 3674.1 4129.7 4287.4 4393.9 4418.1 3718.7 3722.8 3842.1 3856.4 3893.7 1221.5 1226.4 1227.7 1250.1 1254.2 719.0 829.4 838.2 849.8 856.3 5284.3 5322.3 5438.7 5451.8 5500.4 409.1 412.9 420.6 421.6 423.1 3629.8 3740.6 3786.2 3812.3 3820.3 9597.5 9885.7 9943.7 9993.0 10046.0 9627.2 9832.8 9862.9 9945.5 9964.6 6902.8 7031.9 7129.1 7166.3 7178.4 5419.9 5421.1 5449.2 5455.7 5535.5 8972.7 9089.0 9115.3 9197.6 9282.1 9134.9 9226.6 9288.7 9299.3 9441.7 5735.4 6512.6 6696.4 7069.4 7112.2 7477.5 7632.4 7679.6 7684.7 7706.6 6653.2 6770.0 6790.7 6811.1 6935.7 6460.6 6564.7 6628.2 6634.2 6760.9 6152.8 6179.7 6180.0 6180.9 6186.4 4452.2 4531.7 4623.0 4671.0 4700.7 4582.1 4671.7 4700.3 4716.4 4821.2 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | [#4] prototype.html Cycles:180 Average:4283.94 Median:4644.80 stddev:1240.24 (26.7%) stddev-sans-first:1207.10 18:20:35 INFO - PROCESS | 21726 | Values: 298.2 301.7 311.0 314.1 314.8 4905.3 4979.0 4981.8 5088.7 5119.3 4993.7 5001.0 5008.3 5023.5 5036.6 3952.5 3956.4 3958.5 3967.3 3969.3 3871.1 3928.7 3958.2 3972.5 3980.2 3893.4 3926.1 3928.8 3929.3 3937.4 3903.9 3911.5 3916.1 3946.2 3947.2 3489.7 3499.7 3500.7 3512.6 3522.2 4662.5 4940.3 4963.8 4985.7 5005.6 4456.4 4458.5 4468.8 4473.3 4475.4 5239.5 5264.2 5292.2 5296.0 5299.4 3660.9 3696.3 3718.7 3732.8 3759.0 5461.8 5470.6 5478.7 5498.2 5516.6 3786.1 3786.2 3792.4 3796.1 3796.2 3768.5 3842.6 3845.4 3851.4 3858.6 4380.7 4400.2 4403.3 4405.9 4441.2 5297.6 5325.0 5329.8 5341.1 5344.8 1240.8 1301.7 1338.0 1339.1 1348.8 892.3 908.1 923.6 929.6 934.5 4583.8 4585.6 4596.3 4610.6 4627.1 5346.2 5366.9 5378.9 5432.4 5439.4 4459.6 4553.4 4574.9 4576.3 4624.7 2532.7 2551.7 2561.5 2573.4 2582.5 4569.5 4590.7 4595.3 4602.2 4607.8 4573.8 4881.5 4894.0 4902.8 4937.0 4455.9 4474.4 4484.8 4492.8 4495.5 4765.4 4765.9 4780.3 4786.8 4809.1 4690.7 4756.2 4764.3 4773.3 4799.7 4766.3 5140.7 5155.7 5161.6 5170.0 3817.4 3875.9 3875.9 3891.7 3912.2 5088.6 5532.1 5539.3 5543.2 5547.5 5015.9 5261.1 5261.6 5274.9 5279.4 5280.3 5290.6 5292.7 5301.0 5304.8 4962.9 5126.4 5143.7 5177.9 5194.6 5247.3 5353.2 5359.2 5369.6 5373.8 5213.5 5227.5 5249.4 5262.6 5278.9 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - PROCESS | 21726 | [#5] yui.html Cycles:180 Average:16424.54 Median:502.50 stddev:23530.16 (4682.6%) stddev-sans-first:23566.17 18:20:35 INFO - PROCESS | 21726 | Values: 598.9 604.1 624.4 683.4 696.9 12345.7 12359.3 12962.6 13039.3 13041.9 12016.3 12034.5 12098.6 12123.6 12272.2 735.4 747.5 756.0 756.6 757.1 614.0 734.6 753.5 759.0 767.2 806.0 806.1 809.6 811.8 814.3 796.4 804.6 804.6 805.0 806.4 583.0 584.4 590.6 590.6 590.9 12692.7 12701.0 12701.3 12708.2 12732.0 11500.7 11677.9 12121.0 12202.0 12569.6 10103.5 10208.6 10245.3 10309.8 10487.4 3201.3 3224.2 3231.6 3234.8 3405.7 61584.4 62834.4 63079.0 63514.4 63528.7 8942.1 9082.1 9381.6 9633.6 9694.4 19647.4 19650.0 19709.1 19748.8 20064.6 6479.5 6536.2 6696.6 6746.7 6824.1 3696.4 3697.6 3721.2 3730.2 3740.6 2778.2 2867.9 2918.2 2921.3 2940.9 484.9 493.2 493.7 496.4 508.6 486.6 514.6 531.5 536.3 542.4 6408.8 6759.5 6900.5 7005.3 7341.4 462.9 513.3 532.8 533.6 535.4 3176.2 3353.4 3424.7 3472.8 3526.9 90432.0 95026.5 97114.5 97301.5 99776.5 48062.0 48461.0 48875.8 48938.5 79389.0 70250.0 75172.0 75282.2 76208.2 77317.6 6494.4 6509.6 6537.2 6645.1 6882.8 42992.8 44722.8 44838.8 45255.8 45586.5 47037.5 47386.8 61276.4 63320.7 72108.0 10662.3 10950.5 11021.1 11142.7 11706.6 11450.6 11558.5 11598.0 11678.9 11993.8 9925.8 10077.5 10375.0 10409.5 10712.2 10114.5 10299.4 10495.6 10657.1 10751.9 10064.8 10247.2 10346.5 10359.1 10525.7 8545.6 8551.9 8589.1 8673.9 9129.5 8818.7 8932.5 9402.9 9406.6 9467.4 18:20:35 INFO - PROCESS | 21726 | -------- Summary: end -------- 18:20:35 INFO - PROCESS | 21726 | 18:20:35 INFO - TEST-INFO | 21726: exit 0 18:20:35 INFO - TEST-OK | dromaeo_css | took 1117597ms 18:20:35 INFO - TEST-START | kraken 18:20:35 INFO - operating with platform_type : linux_ 18:20:35 INFO - Initialising browser for kraken test... 18:20:35 INFO - TEST-INFO | started process 21969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxmhLb/profile http://localhost:59695/getInfo.html) 18:20:39 INFO - PROCESS | 21969 | JavaScript error: , line 0: uncaught exception: undefined 18:20:40 INFO - PROCESS | 21969 | __metrics Screen width/height:1600/1200 18:20:40 INFO - PROCESS | 21969 | colorDepth:24 18:20:40 INFO - PROCESS | 21969 | Browser inner width/height: 1024/697 18:20:40 INFO - PROCESS | 21969 | __metrics 18:20:41 ERROR - PROCESS | 21969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 18:20:42 INFO - TEST-INFO | 21969: exit 0 18:20:42 INFO - Browser initialized. 18:20:42 INFO - Running cycle 1/1 for kraken test... 18:20:42 INFO - TEST-INFO | started process 22089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxmhLb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:54 INFO - PROCESS | 22089 | RSS: Main: 165625856 18:20:54 INFO - PROCESS | 22089 | 18:20:56 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59695/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:57 INFO - PROCESS | 22089 | RSS: Main: 170811392 18:20:57 INFO - PROCESS | 22089 | 18:21:00 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59695/tests/kraken/driver.html?testName=audio-dft) 18:21:01 INFO - PROCESS | 22089 | RSS: Main: 169963520 18:21:01 INFO - PROCESS | 22089 | 18:21:04 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59695/tests/kraken/driver.html?testName=audio-fft) 18:21:04 INFO - PROCESS | 22089 | RSS: Main: 165756928 18:21:04 INFO - PROCESS | 22089 | 18:21:06 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59695/tests/kraken/driver.html?testName=audio-oscillator) 18:21:07 INFO - PROCESS | 22089 | RSS: Main: 167198720 18:21:07 INFO - PROCESS | 22089 | 18:21:09 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59695/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:21:10 INFO - PROCESS | 22089 | RSS: Main: 167276544 18:21:10 INFO - PROCESS | 22089 | 18:21:13 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59695/tests/kraken/driver.html?testName=imaging-darkroom) 18:21:14 INFO - PROCESS | 22089 | RSS: Main: 167587840 18:21:14 INFO - PROCESS | 22089 | 18:21:17 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59695/tests/kraken/driver.html?testName=imaging-desaturate) 18:21:18 INFO - PROCESS | 22089 | RSS: Main: 164499456 18:21:18 INFO - PROCESS | 22089 | 18:21:21 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59695/tests/kraken/driver.html?testName=json-parse-financial) 18:21:22 INFO - PROCESS | 22089 | RSS: Main: 166723584 18:21:22 INFO - PROCESS | 22089 | 18:21:23 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59695/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:21:24 INFO - PROCESS | 22089 | RSS: Main: 166809600 18:21:24 INFO - PROCESS | 22089 | 18:21:26 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:21:27 INFO - PROCESS | 22089 | RSS: Main: 167100416 18:21:27 INFO - PROCESS | 22089 | 18:21:29 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:21:29 INFO - PROCESS | 22089 | RSS: Main: 167563264 18:21:29 INFO - PROCESS | 22089 | 18:21:32 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:21:33 INFO - PROCESS | 22089 | RSS: Main: 167706624 18:21:33 INFO - PROCESS | 22089 | 18:21:36 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:21:36 INFO - PROCESS | 22089 | RSS: Main: 168030208 18:21:36 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | Cycle 1(1): loaded http://localhost:59695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59695/tests/kraken/driver.html?testName=ai-astar) 18:21:38 INFO - PROCESS | 22089 | RSS: Main: 168714240 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | __start_tp_report 18:21:38 INFO - PROCESS | 22089 | _x_x_mozilla_page_load 18:21:38 INFO - PROCESS | 22089 | _x_x_mozilla_page_load_details 18:21:38 INFO - PROCESS | 22089 | |i|pagename|runs| 18:21:38 INFO - PROCESS | 22089 | |0;ai-astar;105;117;109;114;114;115;117;116;115;114 18:21:38 INFO - PROCESS | 22089 | |1;audio-beat-detection;159;129;146;184;130;155;149;129;181;125 18:21:38 INFO - PROCESS | 22089 | |2;audio-dft;165;167;166;178;163;163;167;166;162;164 18:21:38 INFO - PROCESS | 22089 | |3;audio-fft;76;76;78;172;77;78;78;77;158;78 18:21:38 INFO - PROCESS | 22089 | |4;audio-oscillator;87;87;160;86;86;87;132;87;86;134 18:21:38 INFO - PROCESS | 22089 | |5;imaging-gaussian-blur;119;119;120;119;119;118;119;119;119;118 18:21:38 INFO - PROCESS | 22089 | |6;imaging-darkroom;149;149;148;148;149;149;151;149;149;148 18:21:38 INFO - PROCESS | 22089 | |7;imaging-desaturate;96;95;95;95;97;97;96;98;97;97 18:21:38 INFO - PROCESS | 22089 | |8;json-parse-financial;64;64;66;62;63;62;63;63;62;64 18:21:38 INFO - PROCESS | 22089 | |9;json-stringify-tinderbox;66;66;66;66;65;65;65;68;66;65 18:21:38 INFO - PROCESS | 22089 | |10;stanford-crypto-aes;80;80;87;81;82;79;81;81;85;81 18:21:38 INFO - PROCESS | 22089 | |11;stanford-crypto-ccm;137;132;144;143;140;138;141;133;176;136 18:21:38 INFO - PROCESS | 22089 | |12;stanford-crypto-pbkdf2;175;168;166;166;170;169;172;168;169;164 18:21:38 INFO - PROCESS | 22089 | |13;stanford-crypto-sha256-iterative;68;68;81;70;68;68;68;68;68;69 18:21:38 INFO - PROCESS | 22089 | __end_tp_report 18:21:38 INFO - PROCESS | 22089 | __start_cc_report 18:21:38 INFO - PROCESS | 22089 | _x_x_mozilla_cycle_collect,967 18:21:38 INFO - PROCESS | 22089 | __end_cc_report 18:21:38 INFO - PROCESS | 22089 | __startTimestamp1469496098934__endTimestamp 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | ------- Summary: start ------- 18:21:38 INFO - PROCESS | 22089 | Number of tests: 14 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.78 (3.3%) stddev-sans-first:2.40 18:21:38 INFO - PROCESS | 22089 | Values: 105.0 117.0 109.0 114.0 114.0 115.0 117.0 116.0 115.0 114.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.00 stddev:21.42 (14.1%) stddev-sans-first:22.39 18:21:38 INFO - PROCESS | 22089 | Values: 159.0 129.0 146.0 184.0 130.0 155.0 149.0 129.0 181.0 125.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:4.53 (2.7%) stddev-sans-first:4.79 18:21:38 INFO - PROCESS | 22089 | Values: 165.0 167.0 166.0 178.0 163.0 163.0 167.0 166.0 162.0 164.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.50 stddev:37.15 (47.9%) stddev-sans-first:38.78 18:21:38 INFO - PROCESS | 22089 | Values: 76.0 76.0 78.0 172.0 77.0 78.0 78.0 77.0 158.0 78.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:86.50 stddev:27.77 (32.1%) stddev-sans-first:28.83 18:21:38 INFO - PROCESS | 22089 | Values: 87.0 87.0 160.0 86.0 86.0 87.0 132.0 87.0 86.0 134.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:21:38 INFO - PROCESS | 22089 | Values: 119.0 119.0 120.0 119.0 119.0 118.0 119.0 119.0 119.0 118.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 18:21:38 INFO - PROCESS | 22089 | Values: 149.0 149.0 148.0 148.0 149.0 149.0 151.0 149.0 149.0 148.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 18:21:38 INFO - PROCESS | 22089 | Values: 96.0 95.0 95.0 95.0 97.0 97.0 96.0 98.0 97.0 97.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:1.25 (2.0%) stddev-sans-first:1.30 18:21:38 INFO - PROCESS | 22089 | Values: 64.0 64.0 66.0 62.0 63.0 62.0 63.0 63.0 62.0 64.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 18:21:38 INFO - PROCESS | 22089 | Values: 66.0 66.0 66.0 66.0 65.0 65.0 65.0 68.0 66.0 65.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:2.45 (3.0%) stddev-sans-first:2.52 18:21:38 INFO - PROCESS | 22089 | Values: 80.0 80.0 87.0 81.0 82.0 79.0 81.0 81.0 85.0 81.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:140.50 stddev:12.58 (9.0%) stddev-sans-first:13.21 18:21:38 INFO - PROCESS | 22089 | Values: 137.0 132.0 144.0 143.0 140.0 138.0 141.0 133.0 176.0 136.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.00 stddev:3.16 (1.9%) stddev-sans-first:2.40 18:21:38 INFO - PROCESS | 22089 | Values: 175.0 168.0 166.0 166.0 170.0 169.0 172.0 168.0 169.0 164.0 18:21:38 INFO - PROCESS | 22089 | 18:21:38 INFO - PROCESS | 22089 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:68.00 stddev:4.06 (6.0%) stddev-sans-first:4.27 18:21:38 INFO - PROCESS | 22089 | Values: 68.0 68.0 81.0 70.0 68.0 68.0 68.0 68.0 68.0 69.0 18:21:38 INFO - PROCESS | 22089 | -------- Summary: end -------- 18:21:38 INFO - PROCESS | 22089 | 18:21:39 INFO - TEST-INFO | 22089: exit 0 18:21:40 INFO - TEST-OK | kraken | took 64131ms 18:21:40 INFO - SUITE-END | took 1181s 18:21:40 INFO - Completed test suite (00:19:41) 18:21:40 INFO - javascript benchmark 18:21:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6474.8474473567985, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2684.0337478507745, 2689.6368990186324, 2716.2530304166353, 2718.1301983365324, 2740.3286194882244, 4703.882402939928, 4883.877903052421, 4896.63275254356, 4907.239377896422, 4935.629827762914, 4800.111979283826, 4833.540813622709, 4851.902961940759, 4860.951390486094, 4915.582175515076, 4466.2184117779425, 4484.663650226246, 4486.932696009562, 4571.200039993005, 4594.104149690812, 4521.502634710179, 4525.502194758574, 4544.318352247156, 4551.317302404649, 4572.039871626946, 4334.219840428722, 4372.978135109304, 4377.212101821671, 4418.64650827933, 4445.488768791598, 4446.4886538047895, 4455.977720111411, 4456.844010459651, 4483.417155769762, 4490.955090449086, 4377.277749171383, 4399.912001759979, 4421.579949904753, 4443.888902777424, 4471.9776401118115, 4709.1288111699105, 4751.97832466018, 4788.257820037899, 4807.471178170398, 4819.204831202847, 5246.422893481714, 5247.632665713401, 5251.212318152269, 5262.0, 5269.314989051437, 5262.394824595182, 5271.532824869157, 5283.128283833163, 5287.973560132214, 5331.093714068579, 4736.739479328601, 4839.903201935942, 4882.7558622068755, 4889.046635906036, 4898.191798353303, 5414.485623865727, 5427.0773968425465, 5433.510984011458, 5475.09660905954, 5488.0, 5164.948350516522, 5171.198464238049, 5192.4807519248525, 5211.348581427322, 5234.895302093937, 5025.472325405853, 5141.717205553656, 5216.58267338612, 5261.657992230569, 5293.470652934676, 5205.193195054772, 5205.531502164823, 5207.0, 5214.504622060898, 5239.1355426354985, 5164.845054648366, 5191.6884986900905, 5205.24523944026, 5207.973960130251, 5269.051570717308, 4254.638355739797, 4314.697971142053, 4347.673924455678, 4348.108637729258, 4365.454318210223, 3762.924741505209, 3781.5084039074745, 3785.356489396809, 3807.0672685192303, 3845.9230815383535, 4471.23988921884, 4474.88127968008, 4489.0, 4502.57225563571, 4521.344405061313, 4976.850694479172, 5079.060373830853, 5093.8726531836255, 5137.460566640524, 5175.560077393388, 4404.097160082176, 4404.207242696345, 4434.82260709568, 4438.134563760101, 4467.039586488921, 4589.242774942164, 4590.219662657356, 4606.907861842811, 4638.721676699409, 4651.37206477128, 4778.761061946958, 4884.975575122102, 4902.779374928136, 4903.872109414926, 4941.50584941503, 5250.97374513125, 5276.894462110659, 5289.709066001406, 5306.602004849575, 5319.547838433777, 4906.2640603909695, 4939.925901111558, 4951.8266860659705, 4954.108260513142, 4979.701217926936, 4955.058538877602, 5078.21287700407, 5107.87230319245, 5144.382674078985, 5220.7650655721345, 5172.301739265151, 5174.120399532164, 5198.870028249324, 5201.505856943584, 5259.237410575522, 5010.724410157476, 5010.849674509771, 5023.673461225008, 5050.267711181785, 5075.695458272516, 4922.901541969212, 4991.47589503097, 5007.774650140679, 5044.066847633199, 5045.823396181116, 4949.727764972961, 4967.9006419870675, 4974.179260422135, 5004.649674522749, 5036.521530454601, 5075.3148324975655, 5123.1034568949535, 5141.53726164647, 5143.92284115731, 5186.0, 4792.496787837227, 4928.236123400879, 4973.129702302155, 4988.55103040728, 5005.274235235943], "value": 4767.689676981609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.0737553534526, 559.3818830192636, 561.1190431023296, 565.8670212500065, 589.1192666962891, 34051.318973620546, 38355.80822095893, 38518.037049073755, 38519.80740096299, 38580.0, 39296.80351598238, 39837.40243896336, 40027.59972400275, 40055.79972100143, 40107.197856042934, 7659.502132361406, 7777.105632852238, 7784.104827944802, 7784.727534536292, 7791.961040194819, 7641.426892983049, 7654.387648988068, 7727.420443466763, 7747.883781743279, 7756.961215193916, 7772.106207786092, 7772.222777722211, 7799.649015794274, 7805.5706936118495, 7821.256980586863, 7725.5364678119495, 7757.5733334666575, 7775.922240777576, 7778.416618753616, 7782.766517004499, 7719.073711154641, 7719.266669666373, 7728.420368472387, 7733.381329493627, 7763.805904852367, 37171.62828371736, 37859.0, 37919.62080379216, 37948.24103517914, 38040.42939355912, 2442.3771938155655, 2947.8673459694364, 3054.511278195478, 3065.065155127685, 3418.6923176913947, 27745.306367340778, 28090.85954570214, 30547.358258645298, 30976.690233097605, 31428.52857207144, 3226.4998925166637, 3273.9836300818583, 3278.1476816027766, 3355.8489867956, 3405.6594340565994, 279678.0, 279944.0, 281482.0, 282420.0, 282718.5864070687, 56450.71774641183, 57245.706572007264, 57450.425495745345, 57537.42462575321, 57639.0, 34182.48726269108, 35044.12389690278, 35227.82386088104, 36984.0, 37035.0, 15785.68428631421, 15953.760693589606, 15989.28048237832, 15997.600059998593, 16092.0, 11574.611046674285, 11676.70808229801, 11708.88291117095, 11718.472668729757, 11722.0, 19210.231590736494, 19218.903905480383, 19424.90287548553, 19425.4172374829, 19454.319098831475, 7156.212816590171, 7193.856122877513, 7373.631318434057, 7405.111386633638, 7498.737544185928, 798.5807451088109, 925.3938670171049, 928.5171710710392, 944.4380593546829, 956.3114557518576, 27625.585616215772, 28126.0, 28277.71722282792, 28344.433111337657, 28821.0, 871.4858233642182, 916.4913473022403, 946.4652471353663, 986.7779749556292, 1035.7928414317166, 14751.262436878113, 14923.850761492464, 15044.849551504563, 15393.23033848303, 15428.997115187476, 395847.0, 398925.0, 399898.0, 399918.0, 400810.0, 50827.7458612712, 51422.22866657003, 51676.0, 51706.48293517092, 51988.0, 1164.0629293418879, 1174.7885380631396, 1196.0670676872053, 1214.878512148778, 1215.817627355886, 26273.0, 26880.865595671898, 27842.860785695942, 27981.720182798726, 28159.15522534327, 37433.25133497369, 38074.8096259528, 38404.615953840104, 38419.231615368095, 38419.80790096032, 275264.0, 277056.0, 277331.0, 279333.0, 280450.0, 23935.521289573764, 24099.879500602387, 24331.148409805573, 24345.513089737753, 24346.0, 42391.0, 42557.0, 42720.0, 42797.0, 42878.571214287454, 34777.47833782546, 36239.45640815337, 36593.81703091467, 37039.629603703615, 37206.6279337214, 36296.27407451889, 36933.81533092317, 37031.8148409267, 40151.59848401479, 40840.59159408368, 34888.0, 36543.0, 37529.62470375261, 37797.62202378051, 37846.81076594599, 37275.62724372721, 37937.4309385365, 38149.23701525899, 38248.808755956044, 38572.6142738569, 29293.26766830846, 29830.25424364408, 30155.547666784576, 30880.691193087783, 31000.84499577578], "value": 17568.40233219816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.81576803714137, 372.1644907183374, 377.97732136071835, 383.3674437178657, 391.8197629090618, 11735.237209581372, 12247.510099596017, 16867.91566042171, 16955.152242387892, 17098.059606721625, 15824.76262856058, 17033.232057523317, 17109.31562737489, 17125.14374281287, 17231.138443077827, 4986.326845875806, 5162.948370516285, 5171.870703232412, 5191.091558977183, 5210.5310522053005, 5044.82343117991, 5059.620528460362, 5091.516305950929, 5095.133827249377, 5095.235714642796, 5069.797208111671, 5327.668082979255, 5364.7317634118335, 5381.946180538203, 5406.675599464025, 5355.732213389334, 5392.541633961118, 5844.298684157929, 5944.405559444064, 5955.553333500005, 5243.2659427680155, 5269.130593452076, 5288.471152884719, 5292.841214763564, 5318.095923692981, 19958.900205498878, 20024.399268021836, 20318.898405507876, 20361.694574581394, 20635.89682051595, 1854.4900152458047, 1898.364048043907, 1928.7781905080956, 2069.968950465729, 2312.9476088379747, 9126.26989840811, 9210.769730756718, 11987.340696261703, 12455.813162802566, 13520.0, 1671.6907372136072, 1710.4868539438244, 1730.832576385212, 1744.0756399108493, 1804.6300508395748, 51133.48866511325, 79608.99999999942, 79904.60047699782, 81601.92502583463, 82224.58887705582, 16181.676366472604, 16620.83379166217, 17003.0, 17064.914675426542, 17088.0, 28452.573211401846, 28540.571891421645, 28576.71386289092, 28629.28426789347, 28809.279768005967, 9264.583093760797, 9455.810883782286, 9568.61725530985, 9778.65774697882, 9808.705738827846, 7919.84160316802, 7921.1682773307975, 7949.682012719427, 8005.359571234288, 8193.09875913649, 8288.254057134887, 8490.745277641558, 8512.276456501268, 8631.784205394915, 8692.783340248323, 3215.340855124694, 3320.8505617247283, 3395.1094850434474, 3433.296174284266, 3536.929261414757, 773.2615352338615, 827.4497459189691, 874.2001069021901, 877.3989816975393, 934.6541779541614, 16000.679986400439, 16591.41930032443, 17106.743398849027, 17442.738358924627, 17517.386891458736, 857.9442336248123, 861.573521107056, 884.6461415433878, 915.3866909170871, 930.4277869110448, 8967.103289671111, 9428.952855235817, 9480.288978326653, 9555.856662150074, 9700.223982081416, 386872.0, 390615.0, 391263.0, 393724.0, 394623.0, 46273.768631157305, 50596.241056384184, 76240.23759762332, 76342.61828690932, 83437.58281208554, 899.3839220134229, 909.6406919266852, 920.9723708288763, 924.7456949338851, 928.6471140966389, 13975.860241397455, 15129.243537822844, 15294.311755970786, 15402.15288159162, 15671.373145074069, 37949.81025094857, 38346.233075338896, 38405.23189536138, 38505.422418664304, 38653.613463866124, 48113.75943120262, 49784.50215497943, 53139.734301328244, 53650.46349536454, 54593.1811022827, 7664.425168112302, 7736.2650548197835, 7745.148033716174, 7806.180351063056, 8231.670733170606, 8979.595918183828, 11327.271550930433, 11811.232269902428, 11830.526778928746, 12083.697907552381, 9394.812103758024, 9654.372465789702, 9733.610655573697, 10053.19574434058, 10148.898511015092, 9648.179904708179, 10118.949405252926, 10367.222458315808, 10405.84391234117, 10680.305780124267, 9517.333786635147, 9889.604415823287, 10225.693229203136, 10356.067953884187, 10808.297460665031, 7416.8887466686965, 7887.84224315499, 7940.404469664682, 8025.638846252049, 8363.121872203574, 9239.39943903644, 9516.095970882756, 9813.705588832347, 10088.293819432569, 10525.78948421012], "value": 8906.255591279052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.086232655284, 1427.357689039932, 1511.8866085043617, 1679.4625719769679, 1722.4832550234926, 6807.6596170191415, 7398.6670599823, 7701.6919323227075, 8217.178282171788, 8231.094579596247, 7565.432592555553, 7828.921710782891, 7850.6074696265105, 7854.293113619773, 7869.134395216536, 2211.5355775287167, 2247.224707475918, 2251.2120757734824, 2254.222293308806, 2257.661350797377, 2156.676498525218, 2177.9019944102474, 2199.516106456577, 2222.677711731806, 2229.7101376820992, 2189.0696454006984, 2192.6601376786543, 2197.3517812245427, 2204.7464541577683, 2245.079517397867, 2178.1287485005964, 2181.2474696229774, 2196.3081629286803, 2196.714427124464, 2210.049678638185, 2161.718976533041, 2182.0399024429357, 2183.585118827418, 2189.6058709432295, 2193.813525850289, 7919.524828510308, 8005.599720013976, 8006.799830004238, 8006.879896801553, 8033.1163572007035, 4667.393238878958, 4766.475687674353, 4822.445418776851, 4822.517748225185, 4830.855074347775, 2947.9318540414306, 3063.0855715178013, 3088.4286407014774, 3100.3489267253904, 3114.68853114689, 966.3622009473784, 973.2214228617078, 998.4408731110601, 1006.6023920551414, 1018.6689325969089, 11293.20947533673, 11343.546258149665, 11386.373749443777, 11429.114196157623, 11451.59919402817, 4109.671226301889, 4352.564743525622, 4460.219461594273, 4468.754218518013, 4496.0558282760985, 9548.283878708986, 9606.519674016272, 9621.807563848684, 9622.951885240669, 9629.903700963041, 4747.098051370229, 4757.714537127784, 4761.047790441926, 4780.995990841962, 4791.281307803857, 3674.11821162919, 4129.731567448106, 4287.399764033038, 4393.912121757547, 4418.072204836956, 3718.7396882217986, 3722.7766334020043, 3842.1355195080882, 3856.382978723391, 3893.7469064511283, 1221.5175005872632, 1226.3500344817262, 1227.7360367521026, 1250.143651598658, 1254.1597129922973, 718.9532680375759, 829.4359835312046, 838.2162677896187, 849.7705619482705, 856.267890953226, 5284.286621306152, 5322.33470816148, 5438.673679579238, 5451.809186678447, 5500.4224556420995, 409.06528582189554, 412.9236091323055, 420.6235419299771, 421.58473903205316, 423.1072437157595, 3629.8366573504254, 3740.6259374062374, 3786.2427514497213, 3812.313783518993, 3820.3123437781464, 9597.472139032281, 9885.703428897144, 9943.651972180938, 9993.0, 10046.04562566555, 9627.208109648263, 9832.754181145528, 9862.852057219005, 9945.502724863727, 9964.601415943425, 6902.757503649291, 7031.8945215821805, 7129.108861392326, 7166.319199676022, 7178.4257259420165, 5419.918701219563, 5421.132618780976, 5449.209864569694, 5455.672659640434, 5535.474129957647, 8972.730818075468, 9089.0, 9115.27077833785, 9197.586108624993, 9282.071792820663, 9134.908650913405, 9226.630934762803, 9288.72133835986, 9299.302552308469, 9441.669541566012, 5735.426457354231, 6512.5766825156215, 6696.397324240842, 7069.434445244471, 7112.217656057933, 7477.476576639583, 7632.3512501438, 7679.616019199129, 7684.731034413769, 7706.576138312223, 6653.168353955755, 6769.9661501694145, 6790.72837086511, 6811.114555107804, 6935.687894044881, 6460.612363258219, 6564.671766411565, 6628.171478565179, 6634.203895532567, 6760.884454065024, 6152.815415537541, 6179.6910154493, 6180.042093475518, 6180.907286390798, 6186.443220110212, 4452.154090722753, 4531.660125490667, 4622.953770462387, 4670.953290467051, 4700.694454860423, 4582.106489234568, 4671.696339737906, 4700.318453824245, 4716.363290955677, 4821.156297647968], "value": 4143.800383584345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.19487384063024, 301.65761860288575, 311.0450915688836, 314.0719174838353, 314.7843727046973, 4905.33777939978, 4978.975105124474, 4981.775820088095, 5088.669236499634, 5119.283300337951, 4993.651714037208, 5001.0, 5008.2738002989545, 5023.497650234975, 5036.632782592176, 3952.4664170336923, 3956.4460975463458, 3958.5447673517483, 3967.3453880109746, 3969.28552860485, 3871.1483473635894, 3928.666063384616, 3958.188571342868, 3972.463717398143, 3980.1641655252433, 3893.4159876018684, 3926.1362500249897, 3928.7642741435607, 3929.332013557688, 3937.3503371943593, 3903.9354107025847, 3911.4915061042166, 3916.0992971616547, 3946.1910308386714, 3947.210557888434, 3489.7382696297877, 3499.720022398202, 3500.6674365935196, 3512.648735126467, 3522.189896323834, 4662.487126416091, 4940.308356830046, 4963.759060234941, 4985.651004429691, 5005.599552035828, 4456.442944631921, 4458.487273963503, 4468.82124715011, 4473.284274516094, 4475.39582156408, 5239.528442440161, 5264.236685680593, 5292.179712144623, 5295.973520132413, 5299.364076310829, 3660.853565857389, 3696.316181506403, 3718.721095917817, 3732.7976493868746, 3758.981205093957, 5461.808836690737, 5470.64440811346, 5478.698671573062, 5498.202760599691, 5516.641418307838, 3786.088025547081, 3786.2238241160494, 3792.388235000114, 3796.126890815128, 3796.1838204786104, 3768.5477742671055, 3842.634949679776, 3845.384738441836, 3851.4030325299623, 3858.6334298241622, 4380.685794261709, 4400.163968845909, 4403.304727679866, 4405.876501492099, 4441.200583894865, 5297.576193904479, 5324.9733751331, 5329.786808527616, 5341.145416733304, 5344.75948582307, 1240.838690970168, 1301.7071158989152, 1337.9598612041655, 1339.069346803962, 1348.8381394232754, 892.3352102683542, 908.1191244492964, 923.5936188077225, 929.5631053404888, 934.5187228577288, 4583.816647334136, 4585.587297143273, 4596.333531637893, 4610.631149508032, 4627.120847039052, 5346.198070289488, 5366.892662146814, 5378.91931621026, 5432.429594892558, 5439.428859969726, 4459.554044595515, 4553.408056952575, 4574.931376029363, 4576.290674945389, 4624.722516648944, 2532.696076470835, 2551.668283123182, 2561.4877024595157, 2573.4081161332624, 2582.496413199408, 4569.497355290915, 4590.71763688964, 4595.310703394518, 4602.217623004098, 4607.76961151941, 4573.8274319697875, 4881.51184881509, 4894.042383046739, 4902.828401005948, 4936.950630493721, 4455.910881782346, 4474.373587697725, 4484.798184081724, 4492.820287188476, 4495.527969563149, 4765.404324459442, 4765.928511072406, 4780.251355470548, 4786.784594693317, 4809.134355815987, 4690.671652984258, 4756.192646794196, 4764.2615394613895, 4773.284007398918, 4799.736014519095, 4766.308885211694, 5140.742962851918, 5155.716435596079, 5161.561267292323, 5169.974150129226, 3817.370133927982, 3875.8643447479203, 3875.87599596114, 3891.703894702139, 3912.2175564886566, 5088.59609268506, 5532.1425179097305, 5539.307586551681, 5543.1962365455975, 5547.528460080777, 5015.899682006267, 5261.080100544082, 5261.579073674174, 5274.8945021100135, 5279.39286982002, 5280.287161233338, 5290.619221350331, 5292.682439053669, 5300.9734951325, 5304.825021741068, 4962.925556116589, 5126.359205099363, 5143.665661731976, 5177.948220517746, 5194.558462530727, 5247.347085668002, 5353.223782551586, 5359.169328754049, 5369.597280203922, 5373.838784836461, 5213.478652134756, 5227.451117632594, 5249.396319423316, 5262.552683021833, 5278.89442211146], "value": 3892.408548178301, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.9371116032817, 604.1330690459195, 624.378743150565, 683.402023229674, 696.8884978403453, 12345.691357716061, 12359.258444493315, 12962.611121666341, 13039.282839443827, 13041.934790326048, 12016.339101349422, 12034.518619255241, 12098.637040888787, 12123.575674851381, 12272.20230685005, 735.4263674334014, 747.4692967992731, 755.9697612095537, 756.6065645864147, 757.0574634579956, 614.0328981853576, 734.5629350536449, 753.4838635534649, 759.036024249206, 767.1982777996978, 806.0408114343912, 806.0689903161857, 809.5952023988006, 811.8051667599792, 814.2590242878981, 796.366888323784, 804.5655346113092, 804.5896592737716, 805.0299389235956, 806.4395245304545, 583.0, 584.4418580255888, 590.5570821883588, 590.6190507122925, 590.9113632955048, 12692.682682932907, 12701.0, 12701.301428421433, 12708.237505749685, 12732.04509661779, 11500.654980350602, 11677.883221167764, 12121.0, 12202.0, 12569.622911312676, 10103.494825258707, 10208.591656333738, 10245.334053286588, 10309.845352319646, 10487.37075775456, 3201.27971206479, 3224.193951512122, 3231.628362738292, 3234.7735658503916, 3405.7445691572984, 61584.38415615831, 62834.37165628331, 63079.0, 63514.364856351305, 63528.682356587924, 8942.105789421006, 9082.091790820865, 9381.577828997712, 9633.566489507988, 9694.418334899929, 19647.410577682407, 19650.0, 19709.11308991099, 19748.802511974984, 20064.59870802576, 6479.481641468671, 6536.207805644827, 6696.59820410777, 6746.696398661974, 6824.078749368771, 3696.4085746280466, 3697.574778900407, 3721.218544105768, 3730.235301763132, 3740.569834469071, 2778.1804367711575, 2867.8709458074436, 2918.1829087855435, 2921.3426978929997, 2940.867660955262, 484.94180698316427, 493.2133247470279, 493.7284493528545, 496.3720893070269, 508.6261597725669, 486.5839707050421, 514.5960421069442, 531.455258360184, 536.3269097282885, 542.378976072395, 6408.807735767934, 6759.526833121733, 6900.5163889762935, 7005.334493223238, 7341.375983041501, 462.8958484340996, 513.2942204468856, 532.7735712322248, 533.6131304803986, 535.3923297057789, 3176.1900715317447, 3353.4299169141304, 3424.74314426419, 3472.8437220325145, 3526.894193174209, 90432.0, 95026.52486737522, 97114.5144274274, 97301.51349243209, 99776.50111749394, 48062.0, 48461.0, 48875.75562122238, 48938.510614894105, 79389.0, 70250.0, 75172.0, 75282.24717752862, 76208.23791762123, 77317.61341193259, 6494.350564943468, 6509.641969691523, 6537.182852143482, 6645.1361323027695, 6882.7591034313555, 42992.78503607587, 44722.77638611786, 44838.775806120764, 45255.7737211325, 45586.54413455823, 47037.529624704686, 47386.763066184445, 61276.38723612707, 63320.683396582725, 72108.0, 10662.306950048222, 10950.507227174638, 11021.118310535297, 11142.721431964266, 11706.590269340531, 11450.599229026944, 11558.537658493902, 11598.0, 11678.941605291919, 11993.760124797629, 9925.751856203653, 10077.496125193858, 10375.0, 10409.47952602382, 10712.196585256293, 10114.494275286354, 10299.433531155859, 10495.580176792842, 10657.094146997591, 10751.892481075089, 10064.798704025732, 10247.231457640855, 10346.482675866328, 10359.05881178743, 10525.684229473129, 8545.615447304763, 8551.8717219243, 8589.14108589136, 8673.913260867563, 9129.45223286605, 8818.735437936872, 8932.508712020901, 9402.905970940203, 9406.623735050522, 9467.437872751194], "value": 6123.1538863955075, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 109.0, 114.0, 114.0, 115.0, 117.0, 116.0, 115.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 146.0, 184.0, 130.0, 155.0, 149.0, 129.0, 181.0, 125.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 166.0, 178.0, 163.0, 163.0, 167.0, 166.0, 162.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 172.0, 77.0, 78.0, 78.0, 77.0, 158.0, 78.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 160.0, 86.0, 86.0, 87.0, 132.0, 87.0, 86.0, 134.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 120.0, 119.0, 119.0, 118.0, 119.0, 119.0, 119.0, 118.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 149.0, 149.0, 151.0, 149.0, 149.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 97.0, 97.0, 96.0, 98.0, 97.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 68.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 87.0, 81.0, 82.0, 79.0, 81.0, 81.0, 85.0, 81.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 144.0, 143.0, 140.0, 138.0, 141.0, 133.0, 176.0, 136.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 168.0, 166.0, 166.0, 170.0, 169.0, 172.0, 168.0, 169.0, 164.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 81.0, 70.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "value": 69.6, "unit": "score"}]}]} 18:21:40 INFO - Return code: 0 18:21:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:21:40 ERROR - # TBPL SUCCESS # 18:21:40 INFO - Running post-action listener: _resource_record_post_action 18:21:40 INFO - [mozharness: 2016-07-26 01:21:40.224028Z] Finished run-tests step (success) 18:21:40 INFO - Running post-run listener: _resource_record_post_run 18:21:40 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535920640; Read time: 64; Write time: 484960 18:21:40 INFO - TinderboxPrint: CPU usage
13.4% 18:21:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 64 18:21:40 INFO - TinderboxPrint: I/O write bytes / time
535,920,640 / 484,960 18:21:40 INFO - TinderboxPrint: CPU idle
8,276.4 (86.6%) 18:21:40 INFO - TinderboxPrint: CPU user
1,222.2 (12.8%) 18:21:40 INFO - TinderboxPrint: Swap in / out
0 / 0 18:21:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246665216; Read time: 0; Write time: 283856 18:21:40 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288641024; Read time: 64; Write time: 201104 18:21:40 INFO - Running post-run listener: _upload_blobber_files 18:21:40 INFO - Blob upload gear active. 18:21:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:21:40 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 18:21:40 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'] 18:21:40 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 18:21:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:42 INFO - (blobuploader) - INFO - Done attempting. 18:21:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:21:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:21:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:48 INFO - (blobuploader) - INFO - Done attempting. 18:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:49 INFO - (blobuploader) - INFO - Done attempting. 18:21:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:21:49 INFO - Return code: 0 18:21:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:21:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:21:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/12a569579ad7f81f624247d548703d17196db8a2f7f44181b434511b03e95ffdb63b37196e6bf7e5570e3ef9e822eb95b33e97622eb55cf3b5aacd53a03bac9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dafe87da9602d9bf5bd4dab6b7013de5294d157807c223621f7fabd16d8fc375dcecf950e968944f152ee67a9dc10a78cbd5bf001c749024548ce6fb655fabf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc66a052577d887dbe589c96c9f0dd69035fa0b8f6b6970c5cb5c8ce8089734d239b3f314c9846b7f2fe7a0c20a1a4dd1a711128c4c56ebb207e5dccdd792ae9"} 18:21:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:21:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:21:49 INFO - Contents: 18:21:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/12a569579ad7f81f624247d548703d17196db8a2f7f44181b434511b03e95ffdb63b37196e6bf7e5570e3ef9e822eb95b33e97622eb55cf3b5aacd53a03bac9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dafe87da9602d9bf5bd4dab6b7013de5294d157807c223621f7fabd16d8fc375dcecf950e968944f152ee67a9dc10a78cbd5bf001c749024548ce6fb655fabf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc66a052577d887dbe589c96c9f0dd69035fa0b8f6b6970c5cb5c8ce8089734d239b3f314c9846b7f2fe7a0c20a1a4dd1a711128c4c56ebb207e5dccdd792ae9"} 18:21:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:21:49 INFO - Copying logs to upload dir... 18:21:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:21:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.985236 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-25 18:21:48.997025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 18:21:49.000825) ========= 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=52faae308a556c440401f8e5000001e8-1469494190.594950-198813963 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/12a569579ad7f81f624247d548703d17196db8a2f7f44181b434511b03e95ffdb63b37196e6bf7e5570e3ef9e822eb95b33e97622eb55cf3b5aacd53a03bac9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dafe87da9602d9bf5bd4dab6b7013de5294d157807c223621f7fabd16d8fc375dcecf950e968944f152ee67a9dc10a78cbd5bf001c749024548ce6fb655fabf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc66a052577d887dbe589c96c9f0dd69035fa0b8f6b6970c5cb5c8ce8089734d239b3f314c9846b7f2fe7a0c20a1a4dd1a711128c4c56ebb207e5dccdd792ae9"} build_url:https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/Kg1ILjw5Qr-7sUyCwdzcuA/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/12a569579ad7f81f624247d548703d17196db8a2f7f44181b434511b03e95ffdb63b37196e6bf7e5570e3ef9e822eb95b33e97622eb55cf3b5aacd53a03bac9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dafe87da9602d9bf5bd4dab6b7013de5294d157807c223621f7fabd16d8fc375dcecf950e968944f152ee67a9dc10a78cbd5bf001c749024548ce6fb655fabf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc66a052577d887dbe589c96c9f0dd69035fa0b8f6b6970c5cb5c8ce8089734d239b3f314c9846b7f2fe7a0c20a1a4dd1a711128c4c56ebb207e5dccdd792ae9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 18:21:49.026170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:21:49.026529) ========= 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=52faae308a556c440401f8e5000001e8-1469494190.594950-198813963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 18:21:49.112164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 18:21:49.112493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 18:21:49.112786) ========= ========= Total master_lag: 0.15 =========