builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1469433897.08 results: success (0) buildid: 20160724235127 builduid: 0b1f28f8d7e9463ba7fdc4fcc11eb519 revision: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.084682) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.085139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.085509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.172804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.173153) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 01:04:58-- 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% 65.3M=0s 2016-07-25 01:04:58 (65.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117396 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.325213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.325602) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020363 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.386352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:57.386753) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 --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 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 --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=3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 01:04:59,073 truncating revision to first 12 chars 2016-07-25 01:04:59,073 Setting DEBUG logging. 2016-07-25 01:04:59,073 attempt 1/10 2016-07-25 01:04:59,073 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/05b9ca6b58ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 01:04:59,403 unpacking tar archive at: autoland-05b9ca6b58ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:58.059868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:58.060224) ========= script_repo_revision: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:58.060732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:58.061107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 01:04:58.072116) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-25 01:04:58.072735) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:04:59 INFO - MultiFileLogger online at 20160725 01:04:59 in /builds/slave/test 01:04:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 01:04:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:04:59 INFO - {'append_to_log': False, 01:04:59 INFO - 'base_work_dir': '/builds/slave/test', 01:04:59 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 01:04:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:04:59 INFO - 'branch': 'Autoland-Non-PGO', 01:04:59 INFO - 'buildbot_json_path': 'buildprops.json', 01:04:59 INFO - 'config_files': ('talos/linux_config.py',), 01:04:59 INFO - 'default_actions': ('clobber', 01:04:59 INFO - 'read-buildbot-config', 01:04:59 INFO - 'download-and-extract', 01:04:59 INFO - 'populate-webroot', 01:04:59 INFO - 'create-virtualenv', 01:04:59 INFO - 'install', 01:04:59 INFO - 'run-tests'), 01:04:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:04:59 INFO - 'download_minidump_stackwalk': True, 01:04:59 INFO - 'download_symbols': 'ondemand', 01:04:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:04:59 INFO - 'tooltool.py': '/tools/tooltool.py', 01:04:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:04:59 INFO - '/tools/misc-python/virtualenv.py')}, 01:04:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:04:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:04:59 INFO - 'installer_path': 'installer.exe', 01:04:59 INFO - 'log_level': 'info', 01:04:59 INFO - 'log_name': 'talos', 01:04:59 INFO - 'log_to_console': True, 01:04:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:04:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:04:59 INFO - 'opt_config_files': (), 01:04:59 INFO - 'pip_index': False, 01:04:59 INFO - 'sps_profile': False, 01:04:59 INFO - 'sps_profile_interval': 0, 01:04:59 INFO - 'suite': 'dromaeojs', 01:04:59 INFO - 'system_bits': '32', 01:04:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:04:59 INFO - 'title': 'talos-linux64-ix-059', 01:04:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:04:59 INFO - 'use_talos_json': True, 01:04:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:04:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:04:59 INFO - 'work_dir': 'build'} 01:04:59 INFO - [mozharness: 2016-07-25 08:04:59.854751Z] Running clobber step. 01:04:59 INFO - Running pre-action listener: _resource_record_pre_action 01:04:59 INFO - Running main action method: clobber 01:04:59 INFO - rmtree: /builds/slave/test/build 01:04:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:05:00 INFO - Running post-action listener: _resource_record_post_action 01:05:00 INFO - [mozharness: 2016-07-25 08:05:00.322075Z] Finished clobber step (success) 01:05:00 INFO - [mozharness: 2016-07-25 08:05:00.322180Z] Running read-buildbot-config step. 01:05:00 INFO - Running pre-action listener: _resource_record_pre_action 01:05:00 INFO - Running main action method: read_buildbot_config 01:05:00 INFO - Using buildbot properties: 01:05:00 INFO - { 01:05:00 INFO - "project": "", 01:05:00 INFO - "product": "firefox", 01:05:00 INFO - "script_repo_revision": "production", 01:05:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 01:05:00 INFO - "repository": "", 01:05:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 01:05:00 INFO - "buildid": "20160724235127", 01:05:00 INFO - "pgo_build": "False", 01:05:00 INFO - "basedir": "/builds/slave/test", 01:05:00 INFO - "buildnumber": 95, 01:05:00 INFO - "slavename": "talos-linux64-ix-059", 01:05:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:05:00 INFO - "platform": "ubuntu64_hw", 01:05:00 INFO - "scheduler": "tests-autoland-linux64-talos", 01:05:00 INFO - "branch": "autoland", 01:05:00 INFO - "repo_path": "integration/autoland", 01:05:00 INFO - "revision": "05b9ca6b58ec97e6e73941831fe7a881cb70bcd3", 01:05:00 INFO - "stage_platform": "linux64", 01:05:00 INFO - "builduid": "0b1f28f8d7e9463ba7fdc4fcc11eb519", 01:05:00 INFO - "slavebuilddir": "test" 01:05:00 INFO - } 01:05:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:05:00 INFO - Running post-action listener: _resource_record_post_action 01:05:00 INFO - [mozharness: 2016-07-25 08:05:00.324680Z] Finished read-buildbot-config step (success) 01:05:00 INFO - [mozharness: 2016-07-25 08:05:00.324770Z] Running download-and-extract step. 01:05:00 INFO - Running pre-action listener: _resource_record_pre_action 01:05:00 INFO - Running main action method: download_and_extract 01:05:00 INFO - mkdir: /builds/slave/test/build/tests 01:05:00 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')]} 01:05:00 INFO - https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:05:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:05:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:05:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:02 INFO - Downloaded 1361 bytes. 01:05:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:05:02 INFO - Using the following test package requirements: 01:05:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:05:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:05:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:05:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'jsshell-linux-x86_64.zip'], 01:05:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:05:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:05:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:05:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:05:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:05:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:05:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:05: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')]} 01:05:02 INFO - https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:04 INFO - Downloaded 22737746 bytes. 01:05:04 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'] 01:05:04 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 01:05:05 INFO - Return code: 0 01:05:05 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 01:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:05 INFO - https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:05:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:06 INFO - Downloaded 22737746 bytes. 01:05:06 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'] 01:05:06 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 01:05:08 INFO - Return code: 0 01:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:08 INFO - https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:09 INFO - Downloaded 14403248 bytes. 01:05:09 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'] 01:05:09 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 01:05:09 INFO - Return code: 0 01:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:09 INFO - https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:05:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:05:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:05:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/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 01:05:10 INFO - Downloaded 57163326 bytes. 01:05:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:05:10 INFO - mkdir: /builds/slave/test/properties 01:05:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:05:10 INFO - Writing to file /builds/slave/test/properties/build_url 01:05:10 INFO - Contents: 01:05:10 INFO - build_url:https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:05:11 INFO - Running post-action listener: _resource_record_post_action 01:05:11 INFO - Running post-action listener: set_extra_try_arguments 01:05:11 INFO - [mozharness: 2016-07-25 08:05:11.410904Z] Finished download-and-extract step (success) 01:05:11 INFO - [mozharness: 2016-07-25 08:05:11.411137Z] Running populate-webroot step. 01:05:11 INFO - Running pre-action listener: _resource_record_pre_action 01:05:11 INFO - Running main action method: populate_webroot 01:05:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:05:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:05:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:05:11 INFO - '--tppagecycles', 01:05:11 INFO - '7'], 01:05:11 INFO - 'tests': ['tsvgm']}}, 01:05:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:05:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:05:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:05:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:05:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['damp', 'tps']}, 01:05:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'tests': ['damp', 'tps']}, 01:05:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['dromaeo_dom']}, 01:05:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:05:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['basic_compositor_video']}, 01:05:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:05:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['a11yr', 01:05:11 INFO - 'ts_paint', 01:05:11 INFO - 'tpaint', 01:05:11 INFO - 'sessionrestore', 01:05:11 INFO - 'sessionrestore_no_auto_restore', 01:05:11 INFO - 'tabpaint']}, 01:05:11 INFO - 'other-e10s': {'tests': ['a11yr', 01:05:11 INFO - 'ts_paint', 01:05:11 INFO - 'tpaint', 01:05:11 INFO - 'sessionrestore', 01:05:11 INFO - 'sessionrestore_no_auto_restore', 01:05:11 INFO - 'tabpaint']}, 01:05:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:05:11 INFO - 'ts_paint', 01:05:11 INFO - 'tpaint', 01:05:11 INFO - 'sessionrestore', 01:05:11 INFO - 'sessionrestore_no_auto_restore', 01:05:11 INFO - 'tabpaint']}, 01:05:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:05:11 INFO - 'ts_paint', 01:05:11 INFO - 'tpaint', 01:05:11 INFO - 'sessionrestore', 01:05:11 INFO - 'sessionrestore_no_auto_restore', 01:05:11 INFO - 'tabpaint']}, 01:05:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['a11yr', 01:05:11 INFO - 'ts_paint', 01:05:11 INFO - 'tpaint', 01:05:11 INFO - 'sessionrestore', 01:05:11 INFO - 'sessionrestore_no_auto_restore', 01:05:11 INFO - 'tabpaint']}, 01:05:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['a11yr', 01:05:11 INFO - 'ts_paint', 01:05:11 INFO - 'tpaint', 01:05:11 INFO - 'sessionrestore', 01:05:11 INFO - 'sessionrestore_no_auto_restore', 01:05:11 INFO - 'tabpaint']}, 01:05:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['tsvgx', 01:05:11 INFO - 'tsvgr_opacity', 01:05:11 INFO - 'tart', 01:05:11 INFO - 'tscrollx', 01:05:11 INFO - 'cart']}, 01:05:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:05:11 INFO - 'tsvgr_opacity', 01:05:11 INFO - 'tart', 01:05:11 INFO - 'tscrollx', 01:05:11 INFO - 'cart']}, 01:05:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'talos_options': ['--disable-e10s'], 01:05:11 INFO - 'tests': ['tp5o']}, 01:05:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'tests': ['tp5o']}, 01:05:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'talos_options': ['--disable-e10s', 01:05:11 INFO - '--xperf_path', 01:05:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:11 INFO - 'tests': ['tp5n']}, 01:05:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:11 INFO - 'talos_options': ['--xperf_path', 01:05:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:11 INFO - 'tests': ['tp5n']}}, 01:05:11 INFO - 'talos.zip': {'path': '', 01:05:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:05:11 INFO - Running post-action listener: _resource_record_post_action 01:05:11 INFO - [mozharness: 2016-07-25 08:05:11.431447Z] Finished populate-webroot step (success) 01:05:11 INFO - [mozharness: 2016-07-25 08:05:11.431536Z] Running create-virtualenv step. 01:05:11 INFO - Running pre-action listener: _resource_record_pre_action 01:05:11 INFO - Running main action method: create_virtualenv 01:05:11 INFO - Creating virtualenv /builds/slave/test/build/venv 01:05:11 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 01:05:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:05:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:05:11 INFO - Using real prefix '/usr' 01:05:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:05:12 INFO - Installing distribute.............................................................................................................................................................................................done. 01:05:14 INFO - Installing pip.................done. 01:05:14 INFO - Return code: 0 01:05:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:05:14 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')]} 01:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:14 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')]} 01:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:14 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:14 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 01:05:14 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 01:05:14 INFO - Using env: {'DISPLAY': ':0', 01:05:14 INFO - 'HOME': '/home/cltbld', 01:05:14 INFO - 'LANG': 'en_US.UTF-8', 01:05:14 INFO - 'LANGUAGE': 'en_US:en', 01:05:14 INFO - 'LOGNAME': 'cltbld', 01:05:14 INFO - 'MAIL': '/var/mail/cltbld', 01:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:14 INFO - 'MOZ_NO_REMOTE': '1', 01:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:14 INFO - 'NO_EM_RESTART': '1', 01:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:14 INFO - 'PWD': '/builds/slave/test', 01:05:14 INFO - 'SHELL': '/bin/bash', 01:05:14 INFO - 'SHLVL': '1', 01:05:14 INFO - 'TERM': 'linux', 01:05:14 INFO - 'TMOUT': '86400', 01:05:14 INFO - 'USER': 'cltbld', 01:05:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:14 INFO - '_': '/tools/buildbot/bin/python'} 01:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:14 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 01:05:14 INFO - Cleaning up... 01:05:14 INFO - Return code: 0 01:05:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:05:14 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')]} 01:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:14 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')]} 01:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:14 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:14 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 01:05:14 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 01:05:14 INFO - Using env: {'DISPLAY': ':0', 01:05:14 INFO - 'HOME': '/home/cltbld', 01:05:14 INFO - 'LANG': 'en_US.UTF-8', 01:05:14 INFO - 'LANGUAGE': 'en_US:en', 01:05:14 INFO - 'LOGNAME': 'cltbld', 01:05:14 INFO - 'MAIL': '/var/mail/cltbld', 01:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:14 INFO - 'MOZ_NO_REMOTE': '1', 01:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:14 INFO - 'NO_EM_RESTART': '1', 01:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:14 INFO - 'PWD': '/builds/slave/test', 01:05:14 INFO - 'SHELL': '/bin/bash', 01:05:14 INFO - 'SHLVL': '1', 01:05:14 INFO - 'TERM': 'linux', 01:05:14 INFO - 'TMOUT': '86400', 01:05:14 INFO - 'USER': 'cltbld', 01:05:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:14 INFO - '_': '/tools/buildbot/bin/python'} 01:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:14 INFO - Downloading/unpacking psutil>=3.1.1 01:05:14 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 01:05:14 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 01:05:14 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 01:05:14 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 01:05:14 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 01:05:14 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 01:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:16 INFO - Installing collected packages: psutil 01:05:16 INFO - Running setup.py install for psutil 01:05:16 INFO - building 'psutil._psutil_linux' extension 01:05:16 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 01:05:16 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 01:05:16 INFO - building 'psutil._psutil_posix' extension 01:05:16 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 01:05:16 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 01:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:16 INFO - Successfully installed psutil 01:05:16 INFO - Cleaning up... 01:05:16 INFO - Return code: 0 01:05:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:05:16 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')]} 01:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:16 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')]} 01:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:16 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:16 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 01:05:16 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 01:05:17 INFO - Using env: {'DISPLAY': ':0', 01:05:17 INFO - 'HOME': '/home/cltbld', 01:05:17 INFO - 'LANG': 'en_US.UTF-8', 01:05:17 INFO - 'LANGUAGE': 'en_US:en', 01:05:17 INFO - 'LOGNAME': 'cltbld', 01:05:17 INFO - 'MAIL': '/var/mail/cltbld', 01:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:17 INFO - 'MOZ_NO_REMOTE': '1', 01:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:17 INFO - 'NO_EM_RESTART': '1', 01:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:17 INFO - 'PWD': '/builds/slave/test', 01:05:17 INFO - 'SHELL': '/bin/bash', 01:05:17 INFO - 'SHLVL': '1', 01:05:17 INFO - 'TERM': 'linux', 01:05:17 INFO - 'TMOUT': '86400', 01:05:17 INFO - 'USER': 'cltbld', 01:05:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:17 INFO - '_': '/tools/buildbot/bin/python'} 01:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:05:19 INFO - Installing collected packages: mozsystemmonitor 01:05:19 INFO - Running setup.py install for mozsystemmonitor 01:05:19 INFO - Successfully installed mozsystemmonitor 01:05:19 INFO - Cleaning up... 01:05:19 INFO - Return code: 0 01:05:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:05:19 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')]} 01:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:19 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')]} 01:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:19 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:19 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 01:05:19 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 01:05:19 INFO - Using env: {'DISPLAY': ':0', 01:05:19 INFO - 'HOME': '/home/cltbld', 01:05:19 INFO - 'LANG': 'en_US.UTF-8', 01:05:19 INFO - 'LANGUAGE': 'en_US:en', 01:05:19 INFO - 'LOGNAME': 'cltbld', 01:05:19 INFO - 'MAIL': '/var/mail/cltbld', 01:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:19 INFO - 'MOZ_NO_REMOTE': '1', 01:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:19 INFO - 'NO_EM_RESTART': '1', 01:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:19 INFO - 'PWD': '/builds/slave/test', 01:05:19 INFO - 'SHELL': '/bin/bash', 01:05:19 INFO - 'SHLVL': '1', 01:05:19 INFO - 'TERM': 'linux', 01:05:19 INFO - 'TMOUT': '86400', 01:05:19 INFO - 'USER': 'cltbld', 01:05:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:19 INFO - '_': '/tools/buildbot/bin/python'} 01:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:19 INFO - Downloading/unpacking jsonschema==2.5.1 01:05:19 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 01:05:19 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 01:05:19 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 01:05:19 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 01:05:19 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 01:05:19 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 01:05:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:05:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:05:21 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 01:05:21 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 01:05:21 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 01:05:21 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 01:05:21 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 01:05:21 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 01:05:21 INFO - Downloading functools32-3.2.3-2.tar.gz 01:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:05:21 INFO - warning: no files found matching '*.txt' 01:05:21 INFO - no previously-included directories found matching 'build' 01:05:21 INFO - no previously-included directories found matching 'dist' 01:05:21 INFO - no previously-included directories found matching '.git*' 01:05:21 INFO - Installing collected packages: jsonschema, functools32 01:05:21 INFO - Running setup.py install for functools32 01:05:21 INFO - warning: no files found matching '*.txt' 01:05:21 INFO - no previously-included directories found matching 'build' 01:05:21 INFO - no previously-included directories found matching 'dist' 01:05:21 INFO - no previously-included directories found matching '.git*' 01:05:21 INFO - Successfully installed jsonschema functools32 01:05:21 INFO - Cleaning up... 01:05:21 INFO - Return code: 0 01:05:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:21 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:21 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 01:05:21 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 01:05:21 INFO - Using env: {'DISPLAY': ':0', 01:05:21 INFO - 'HOME': '/home/cltbld', 01:05:21 INFO - 'LANG': 'en_US.UTF-8', 01:05:21 INFO - 'LANGUAGE': 'en_US:en', 01:05:21 INFO - 'LOGNAME': 'cltbld', 01:05:21 INFO - 'MAIL': '/var/mail/cltbld', 01:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:21 INFO - 'MOZ_NO_REMOTE': '1', 01:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:21 INFO - 'NO_EM_RESTART': '1', 01:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:21 INFO - 'PWD': '/builds/slave/test', 01:05:21 INFO - 'SHELL': '/bin/bash', 01:05:21 INFO - 'SHLVL': '1', 01:05:21 INFO - 'TERM': 'linux', 01:05:21 INFO - 'TMOUT': '86400', 01:05:21 INFO - 'USER': 'cltbld', 01:05:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:21 INFO - '_': '/tools/buildbot/bin/python'} 01:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:05:22 INFO - Cleaning up... 01:05:22 INFO - Return code: 0 01:05:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:05: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')]} 01:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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')]} 01:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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', '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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:05: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 blobuploader==1.2.4 01:05:22 INFO - Using env: {'DISPLAY': ':0', 01:05:22 INFO - 'HOME': '/home/cltbld', 01:05:22 INFO - 'LANG': 'en_US.UTF-8', 01:05:22 INFO - 'LANGUAGE': 'en_US:en', 01:05:22 INFO - 'LOGNAME': 'cltbld', 01:05:22 INFO - 'MAIL': '/var/mail/cltbld', 01:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:22 INFO - 'MOZ_NO_REMOTE': '1', 01:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:22 INFO - 'NO_EM_RESTART': '1', 01:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:22 INFO - 'PWD': '/builds/slave/test', 01:05:22 INFO - 'SHELL': '/bin/bash', 01:05:22 INFO - 'SHLVL': '1', 01:05:22 INFO - 'TERM': 'linux', 01:05:22 INFO - 'TMOUT': '86400', 01:05:22 INFO - 'USER': 'cltbld', 01:05:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:22 INFO - '_': '/tools/buildbot/bin/python'} 01:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:22 INFO - Downloading/unpacking blobuploader==1.2.4 01:05: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 01:05: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 01:05: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 01:05: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 01:05: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 01:05: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 01:05:24 INFO - Downloading blobuploader-1.2.4.tar.gz 01:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:05:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:05:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 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 01:05:24 INFO - Downloading docopt-0.6.1.tar.gz 01:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:05:24 INFO - Installing collected packages: blobuploader, requests, docopt 01:05:24 INFO - Running setup.py install for blobuploader 01:05:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:05:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:05:25 INFO - Running setup.py install for requests 01:05:25 INFO - Running setup.py install for docopt 01:05:25 INFO - Successfully installed blobuploader requests docopt 01:05:25 INFO - Cleaning up... 01:05:25 INFO - Return code: 0 01:05:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05: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')]} 01:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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')]} 01:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:25 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:25 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 01:05:25 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 01:05:25 INFO - Using env: {'DISPLAY': ':0', 01:05:25 INFO - 'HOME': '/home/cltbld', 01:05:25 INFO - 'LANG': 'en_US.UTF-8', 01:05:25 INFO - 'LANGUAGE': 'en_US:en', 01:05:25 INFO - 'LOGNAME': 'cltbld', 01:05:25 INFO - 'MAIL': '/var/mail/cltbld', 01:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:25 INFO - 'MOZ_NO_REMOTE': '1', 01:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:25 INFO - 'NO_EM_RESTART': '1', 01:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:25 INFO - 'PWD': '/builds/slave/test', 01:05:25 INFO - 'SHELL': '/bin/bash', 01:05:25 INFO - 'SHLVL': '1', 01:05:25 INFO - 'TERM': 'linux', 01:05:25 INFO - 'TMOUT': '86400', 01:05:25 INFO - 'USER': 'cltbld', 01:05:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:25 INFO - '_': '/tools/buildbot/bin/python'} 01:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:25 INFO - Running setup.py (path:/tmp/pip-bsxDGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:25 INFO - Running setup.py (path:/tmp/pip-myLJuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:25 INFO - Running setup.py (path:/tmp/pip-NYz6ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:25 INFO - Running setup.py (path:/tmp/pip-IDPOZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:26 INFO - Running setup.py (path:/tmp/pip-HdpMW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:26 INFO - Running setup.py (path:/tmp/pip-mAcd_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:26 INFO - Running setup.py (path:/tmp/pip-JeZowd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:26 INFO - Running setup.py (path:/tmp/pip-QXy0HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:26 INFO - Running setup.py (path:/tmp/pip-t8KpA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:26 INFO - Running setup.py (path:/tmp/pip-gdaUei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:26 INFO - Running setup.py (path:/tmp/pip-NfJw2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:26 INFO - Running setup.py (path:/tmp/pip-0hRkqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:26 INFO - Running setup.py (path:/tmp/pip-MM7fgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:26 INFO - Running setup.py (path:/tmp/pip-uVH0c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:26 INFO - Running setup.py (path:/tmp/pip-QkvuZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:26 INFO - Running setup.py (path:/tmp/pip-kKEvIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:26 INFO - Running setup.py (path:/tmp/pip-znbirG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:05:26 INFO - Running setup.py install for manifestparser 01:05:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Running setup.py install for mozcrash 01:05:27 INFO - Running setup.py install for mozdebug 01:05:27 INFO - Running setup.py install for mozdevice 01:05:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Running setup.py install for mozfile 01:05:27 INFO - Running setup.py install for mozhttpd 01:05:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Running setup.py install for mozinfo 01:05:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Running setup.py install for mozInstall 01:05:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Running setup.py install for mozleak 01:05:27 INFO - Running setup.py install for mozlog 01:05:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Running setup.py install for moznetwork 01:05:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:05:28 INFO - Running setup.py install for mozprocess 01:05:28 INFO - Running setup.py install for mozprofile 01:05:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:05:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:05:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:05:28 INFO - Running setup.py install for mozrunner 01:05:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:05:28 INFO - Running setup.py install for mozscreenshot 01:05:28 INFO - Running setup.py install for moztest 01:05:28 INFO - Running setup.py install for mozversion 01:05:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:05:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:05:28 INFO - Cleaning up... 01:05:28 INFO - Return code: 0 01:05:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:28 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:28 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 01:05:28 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 01:05:28 INFO - Using env: {'DISPLAY': ':0', 01:05:28 INFO - 'HOME': '/home/cltbld', 01:05:28 INFO - 'LANG': 'en_US.UTF-8', 01:05:28 INFO - 'LANGUAGE': 'en_US:en', 01:05:28 INFO - 'LOGNAME': 'cltbld', 01:05:28 INFO - 'MAIL': '/var/mail/cltbld', 01:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:28 INFO - 'MOZ_NO_REMOTE': '1', 01:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:28 INFO - 'NO_EM_RESTART': '1', 01:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:28 INFO - 'PWD': '/builds/slave/test', 01:05:28 INFO - 'SHELL': '/bin/bash', 01:05:28 INFO - 'SHLVL': '1', 01:05:28 INFO - 'TERM': 'linux', 01:05:28 INFO - 'TMOUT': '86400', 01:05:28 INFO - 'USER': 'cltbld', 01:05:28 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:28 INFO - '_': '/tools/buildbot/bin/python'} 01:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:28 INFO - Running setup.py (path:/tmp/pip-7Qcdxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:29 INFO - Running setup.py (path:/tmp/pip-Xto5iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:29 INFO - Running setup.py (path:/tmp/pip-hwd5Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:29 INFO - Running setup.py (path:/tmp/pip-GHmM0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:29 INFO - Running setup.py (path:/tmp/pip-Cy_DQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:29 INFO - Running setup.py (path:/tmp/pip-S4K8F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:29 INFO - Running setup.py (path:/tmp/pip-CeXFDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:29 INFO - Running setup.py (path:/tmp/pip-GYVewR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:29 INFO - Running setup.py (path:/tmp/pip-5hLpFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:29 INFO - Running setup.py (path:/tmp/pip-kOTF1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:29 INFO - Running setup.py (path:/tmp/pip-kqhhZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:29 INFO - Running setup.py (path:/tmp/pip-PdV4e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:29 INFO - Running setup.py (path:/tmp/pip-xRJQrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:29 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)) 01:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:29 INFO - Running setup.py (path:/tmp/pip-1o6HCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:30 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)) 01:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:30 INFO - Running setup.py (path:/tmp/pip-YNC_pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:30 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)) 01:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:30 INFO - Running setup.py (path:/tmp/pip-WuHZKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:30 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)) 01:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:30 INFO - Running setup.py (path:/tmp/pip-5JrzXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:30 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)) 01:05:30 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)) 01:05:30 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)) 01:05:30 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)) 01:05:30 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)) 01:05:30 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)) 01:05:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:05: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 01:05: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 01:05: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 01:05: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 01:05: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 01:05: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 01:05:32 INFO - Downloading blessings-1.6.tar.gz 01:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:05:32 INFO - Installing collected packages: blessings 01:05:32 INFO - Running setup.py install for blessings 01:05:32 INFO - Successfully installed blessings 01:05:32 INFO - Cleaning up... 01:05:32 INFO - Return code: 0 01:05:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:32 INFO - Reading from file tmpfile_stdout 01:05:32 INFO - Current package versions: 01:05:32 INFO - argparse == 1.2.1 01:05:32 INFO - blessings == 1.6 01:05:32 INFO - blobuploader == 1.2.4 01:05:32 INFO - docopt == 0.6.1 01:05:32 INFO - functools32 == 3.2.3-2 01:05:32 INFO - jsonschema == 2.5.1 01:05:32 INFO - manifestparser == 1.1 01:05:32 INFO - mozInstall == 1.12 01:05:32 INFO - mozcrash == 0.17 01:05:32 INFO - mozdebug == 0.1 01:05:32 INFO - mozdevice == 0.48 01:05:32 INFO - mozfile == 1.2 01:05:32 INFO - mozhttpd == 0.7 01:05:32 INFO - mozinfo == 0.9 01:05:32 INFO - mozleak == 0.1 01:05:32 INFO - mozlog == 3.3 01:05:32 INFO - moznetwork == 0.27 01:05:32 INFO - mozprocess == 0.23 01:05:32 INFO - mozprofile == 0.28 01:05:32 INFO - mozrunner == 6.12 01:05:32 INFO - mozscreenshot == 0.1 01:05:32 INFO - mozsystemmonitor == 0.3 01:05:32 INFO - moztest == 0.7 01:05:32 INFO - mozversion == 1.4 01:05:32 INFO - psutil == 3.1.1 01:05:32 INFO - requests == 1.2.3 01:05:32 INFO - wsgiref == 0.1.2 01:05:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:32 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')]} 01:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:32 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')]} 01:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:32 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:32 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 01:05:32 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 01:05:32 INFO - Using env: {'DISPLAY': ':0', 01:05:32 INFO - 'HOME': '/home/cltbld', 01:05:32 INFO - 'LANG': 'en_US.UTF-8', 01:05:32 INFO - 'LANGUAGE': 'en_US:en', 01:05:32 INFO - 'LOGNAME': 'cltbld', 01:05:32 INFO - 'MAIL': '/var/mail/cltbld', 01:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:32 INFO - 'MOZ_NO_REMOTE': '1', 01:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:32 INFO - 'NO_EM_RESTART': '1', 01:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:32 INFO - 'PWD': '/builds/slave/test', 01:05:32 INFO - 'SHELL': '/bin/bash', 01:05:32 INFO - 'SHLVL': '1', 01:05:32 INFO - 'TERM': 'linux', 01:05:32 INFO - 'TMOUT': '86400', 01:05:32 INFO - 'USER': 'cltbld', 01:05:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:32 INFO - '_': '/tools/buildbot/bin/python'} 01:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 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)) 01:05:32 INFO - Cleaning up... 01:05:32 INFO - Return code: 0 01:05:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:05:32 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')]} 01:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:32 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')]} 01:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:32 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', '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 01:05:32 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 01:05:32 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 01:05:32 INFO - Using env: {'DISPLAY': ':0', 01:05:32 INFO - 'HOME': '/home/cltbld', 01:05:32 INFO - 'LANG': 'en_US.UTF-8', 01:05:32 INFO - 'LANGUAGE': 'en_US:en', 01:05:32 INFO - 'LOGNAME': 'cltbld', 01:05:32 INFO - 'MAIL': '/var/mail/cltbld', 01:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:32 INFO - 'MOZ_NO_REMOTE': '1', 01:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:32 INFO - 'NO_EM_RESTART': '1', 01:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:32 INFO - 'PWD': '/builds/slave/test', 01:05:32 INFO - 'SHELL': '/bin/bash', 01:05:32 INFO - 'SHLVL': '1', 01:05:32 INFO - 'TERM': 'linux', 01:05:32 INFO - 'TMOUT': '86400', 01:05:32 INFO - 'USER': 'cltbld', 01:05:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:32 INFO - '_': '/tools/buildbot/bin/python'} 01:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:05:33 INFO - Cleaning up... 01:05:33 INFO - Return code: 0 01:05:33 INFO - Running post-action listener: _resource_record_post_action 01:05:33 INFO - Running post-action listener: _start_resource_monitoring 01:05:33 INFO - Starting resource monitoring. 01:05:33 INFO - [mozharness: 2016-07-25 08:05:33.075153Z] Finished create-virtualenv step (success) 01:05:33 INFO - [mozharness: 2016-07-25 08:05:33.075646Z] Running install step. 01:05:33 INFO - Running pre-action listener: _resource_record_pre_action 01:05:33 INFO - Running main action method: install 01:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:33 INFO - Reading from file tmpfile_stdout 01:05:33 INFO - Detecting whether we're running mozinstall >=1.0... 01:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:05:33 INFO - Reading from file tmpfile_stdout 01:05:33 INFO - Output received: 01:05:33 INFO - Usage: mozinstall [options] installer 01:05:33 INFO - Options: 01:05:33 INFO - -h, --help show this help message and exit 01:05:33 INFO - -d DEST, --destination=DEST 01:05:33 INFO - Directory to install application into. [default: 01:05:33 INFO - "/builds/slave/test"] 01:05:33 INFO - --app=APP Application being installed. [default: firefox] 01:05:33 INFO - mkdir: /builds/slave/test/build/application 01:05:33 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'] 01:05:33 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 01:05:49 INFO - Reading from file tmpfile_stdout 01:05:49 INFO - Output received: 01:05:49 INFO - /builds/slave/test/build/application/firefox/firefox 01:05:49 INFO - Running post-action listener: _resource_record_post_action 01:05:49 INFO - [mozharness: 2016-07-25 08:05:49.762759Z] Finished install step (success) 01:05:49 INFO - [mozharness: 2016-07-25 08:05:49.763039Z] Running run-tests step. 01:05:49 INFO - Running pre-action listener: _resource_record_pre_action 01:05:49 INFO - Running main action method: run_tests 01:05:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:05:49 INFO - Python 2.7.3 01:05:49 INFO - Return code: 0 01:05:49 INFO - grabbing minidump binary from tooltool 01:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:49 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 0x16a63b0>, '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 0x16a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:05:49 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 01:05:49 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 01:05:49 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 01:05:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:05:49 INFO - Return code: 0 01:05:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:05:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:05:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:05:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:05:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:05:49 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:05:49 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:05:49 INFO - Using env: {'DISPLAY': ':0', 01:05:49 INFO - 'HOME': '/home/cltbld', 01:05:49 INFO - 'LANG': 'en_US.UTF-8', 01:05:49 INFO - 'LANGUAGE': 'en_US:en', 01:05:49 INFO - 'LOGNAME': 'cltbld', 01:05:49 INFO - 'MAIL': '/var/mail/cltbld', 01:05:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:05:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:49 INFO - 'MOZ_NO_REMOTE': '1', 01:05:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:49 INFO - 'NO_EM_RESTART': '1', 01:05:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:49 INFO - 'PWD': '/builds/slave/test', 01:05:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:05:49 INFO - 'SHELL': '/bin/bash', 01:05:49 INFO - 'SHLVL': '1', 01:05:49 INFO - 'TERM': 'linux', 01:05:49 INFO - 'TMOUT': '86400', 01:05:49 INFO - 'USER': 'cltbld', 01:05:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380', 01:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:49 INFO - '_': '/tools/buildbot/bin/python'} 01:05:49 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:05:50 INFO - mozversion application_buildid: 20160724235127 01:05:50 INFO - mozversion application_changeset: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 01:05:50 INFO - mozversion application_display_name: Nightly 01:05:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:05:50 INFO - mozversion application_name: Firefox 01:05:50 INFO - mozversion application_remotingname: firefox 01:05:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:05:50 INFO - mozversion application_vendor: Mozilla 01:05:50 INFO - mozversion application_version: 50.0a1 01:05:50 INFO - mozversion platform_buildid: 20160724235127 01:05:50 INFO - mozversion platform_changeset: 05b9ca6b58ec97e6e73941831fe7a881cb70bcd3 01:05:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:05:50 INFO - mozversion platform_version: 50.0a1 01:05:50 INFO - using testdate: 1469433950 01:05:50 INFO - actual date: 1469433950 01:05:50 INFO - starting webserver on 'localhost:48702' 01:05:50 INFO - SUITE-START | Running 2 tests 01:05:50 INFO - TEST-START | dromaeo_css 01:05:50 INFO - operating with platform_type : linux_ 01:05:50 INFO - Initialising browser for dromaeo_css test... 01:05:50 INFO - TEST-INFO | started process 24142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGpfRR/profile http://localhost:48702/getInfo.html) 01:05:53 INFO - PROCESS | 24142 | JavaScript error: , line 0: uncaught exception: undefined 01:05:54 INFO - PROCESS | 24142 | __metrics Screen width/height:1600/1200 01:05:54 INFO - PROCESS | 24142 | colorDepth:24 01:05:54 INFO - PROCESS | 24142 | Browser inner width/height: 1024/697 01:05:54 INFO - PROCESS | 24142 | __metrics 01:05:54 INFO - PROCESS | 24142 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:05:54 INFO - PROCESS | 24142 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:05:55 INFO - TEST-INFO | 24142: exit 0 01:05:55 INFO - Browser initialized. 01:05:55 INFO - Running cycle 1/1 for dromaeo_css test... 01:05:55 INFO - TEST-INFO | started process 24225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGpfRR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:06:07 INFO - PROCESS | 24225 | RSS: Main: 159240192 01:06:07 INFO - PROCESS | 24225 | 01:06:59 INFO - PROCESS | 24225 | 1469434019389 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] 01:09:11 INFO - PROCESS | 24225 | Cycle 1(1): loaded http://localhost:48702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48702/tests/dromaeo/cssquery-ext.html) 01:09:12 INFO - PROCESS | 24225 | RSS: Main: 280399872 01:09:12 INFO - PROCESS | 24225 | 01:12:15 INFO - PROCESS | 24225 | Cycle 1(1): loaded http://localhost:48702/tests/dromaeo/cssquery-ext.html (next: http://localhost:48702/tests/dromaeo/cssquery-jquery.html) 01:12:16 INFO - PROCESS | 24225 | RSS: Main: 249569280 01:12:16 INFO - PROCESS | 24225 | 01:15:18 INFO - PROCESS | 24225 | Cycle 1(1): loaded http://localhost:48702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48702/tests/dromaeo/cssquery-mootools.html) 01:15:18 INFO - PROCESS | 24225 | RSS: Main: 231788544 01:15:18 INFO - PROCESS | 24225 | 01:18:21 INFO - PROCESS | 24225 | Cycle 1(1): loaded http://localhost:48702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48702/tests/dromaeo/cssquery-prototype.html) 01:18:21 INFO - PROCESS | 24225 | RSS: Main: 190042112 01:18:21 INFO - PROCESS | 24225 | 01:21:24 INFO - PROCESS | 24225 | Cycle 1(1): loaded http://localhost:48702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48702/tests/dromaeo/cssquery-yui.html) 01:21:25 INFO - PROCESS | 24225 | RSS: Main: 190128128 01:21:25 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | Cycle 1(1): loaded http://localhost:48702/tests/dromaeo/cssquery-yui.html (next: http://localhost:48702/tests/dromaeo/cssquery-dojo.html) 01:24:28 INFO - PROCESS | 24225 | RSS: Main: 283877376 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | __start_tp_report 01:24:28 INFO - PROCESS | 24225 | _x_x_mozilla_page_load 01:24:28 INFO - PROCESS | 24225 | _x_x_mozilla_page_load_details 01:24:28 INFO - PROCESS | 24225 | |i|pagename|runs| 01:24:28 INFO - PROCESS | 24225 | |0;dojo.html;2561.6285638582394;2595.4030572968213;2598.233521111272;2602.7787638050777;2647.6690413698293;4667.463241727202;4745.644076694244;4784.210605250134;4819.1084649339855;4829.37218161639;4790.736509491985;4791.856244312677;4840.903181936359;4865.172920603497;4873.074115917973;4388.034632380871;4421.447319085114;4441.133978874121;4492.797824097907;4515.932261016087;4434.889127771799;4536.387587675671;4560.0879824035155;4568.748718820463;4593.333966574844;4492.011757413364;4530.388397566319;4547.8635640930825;4573.725576465423;4593.540645935396;4354.608085272341;4364.388985542027;4405.185040767468;4406.471223453206;4417.558244175589;4347.30443129101;4389.363542286351;4421.027373977719;4443.155800397914;4483.955160448387;4786.066716990188;4793.544613261734;4838.540338667821;4842.4189097308545;4898.314236006961;4897.804087836482;5062.797488100471;5091;5115.641905066647;5157.896842063138;5151.845444636667;5207.921881171786;5208.947910520884;5217.843464696065;5221.034108689866;4841;4851.320815085891;4879.658423910292;4886.731229782396;4937.481564435682;5163.922541161885;5260.263563101169;5273.419923808378;5309.946900530946;5393.487618676219;5134.818991631945;5153.613478989091;5160.948390516047;5162.199859021857;5162.251473536391;5216.478352164753;5222.477752224747;5261.289725887033;5269.631125821155;5271.262023316739;4958.603311735053;5074.010567939216;5147.0992576298995;5151.793928242903;5152.613553983466;5037.748112594356;5098.031374038921;5107.284980102714;5145.253938179018;5146.768395422215;4388.188185185751;4401.383806267125;4402.757848318373;4403.053343531156;4440;3791.014336272589;3802.9049273767823;3803.7527560708463;3869.3808990561374;3871.399933010388;4376.387305777193;4413.955860441354;4416.094700586372;4450.577195166454;4466.798994045275;5136.743162841918;5138.511841375063;5147.2279158126585;5183.585313174937;5191.532762051434;4410.1400226956075;4414.073044660658;4421.159979603865;4457.8216871324785;4465.531119232433;4503.054358584734;4531.297648864432;4546.158960592301;4567.086582683477;4573.611243044378;4814.085323788469;4828.468868424541;4829.034193161311;4866.635002374836;4877.073356062337;5160.974195129001;5171.844844654666;5176.50823171798;5178.8964220716125;5215.322008138917;4653.86038418848;4755.167845627071;4809.422869255712;4813.03739252144;4870.756462176948;5113.667611605234;5123.3339665843205;5131.743412829269;5149.356330458692;5180.896382072262;5182.585393168612;5195.688258704338;5195.948040519697;5197;5249.107651699144;4846.151923413318;4926.458089610069;4974;5054.4692807254705;5068.518490743373;5003.874903127451;5038.949610503848;5042.974785126051;5080.949190508048;5097.796088156432;4966.577840883565;5016.072026675077;5018.347614810052;5027.2207807789855;5027.798888044437;4879.219324908139;4957.380327459067;4970.105381031449;5055.16589762685;5080.390353157644;4876.4392094909535;4935.506449355035;4941.2835138905375;4961.330220420197;4981.053599816023 01:24:28 INFO - PROCESS | 24225 | |1;ext.html;570.7745440550982;576.6540075954426;580.118220305136;587.9706014699264;597.7250464786198;27520.724792752066;38959.61040389595;39871.40192897109;39917;43668.781656091756;40469.19061618766;40916.79541602295;40932.18135637286;40954.38568421476;40977.18045639093;7561.546307221571;7702.46082774206;7704.26809453101;7705.73029943952;7705.807354816118;7679.846403071935;7706.229377062305;7743.806404839867;7758.883616745753;7759.495632783879;7769.3784497240085;7816.843663126734;7829.6868125275205;7831;7841.647125879321;7740.303372696456;7778.922210777876;7779.105402878628;7783.727569535039;7785.883211751829;7635.389168866477;7699.923000770033;7702.807429814244;7714.6914123435;7717.807054823618;37701;37882.43176352357;38040.23919521594;38162.61837381646;38228.23543529142;2859.589125840718;3060.6633270340244;3242.3353212591364;3683.4658974448553;3696.3346597612417;28982.13053608395;29396.26509337262;29403.41193176146;29526.852365738036;29542;3518.6129525752403;3601.621829707869;3650;3665.7983810890655;3710.77735335878;258313;258524;258717.70641146862;259015;259994;32046.67953320437;32795.67204327974;52954;53217.46782532125;53484.46515534873;33467.832660837026;33547.66452335494;33699.15752106217;33701.66298336985;33706.831465842515;13595.252261125734;13713.520026799015;13714.657133571542;13717.862821371658;13728.794068088986;11302;11402.771944561062;11432.714182145346;11433.199676022765;11492.712682182844;7844.921550784533;7869.055713314439;7882.330001949898;7916.08964969036;7957.283844454027;3095.071478556424;3098.101550550315;3105.875764969421;3115.672854350306;3126.1715645353997;832.2842355574202;874.7856775090144;884.8849649545647;919.9678011269574;1007.1036777268237;27683.307917301827;28129.71870281271;28143.71856281452;28147;28744.856275718488;829.4774292195877;952.7284723853669;986.3440811860177;1014.1835822163082;1023.9913685020249;14663;15119;15309.846901531066;15581;15665;410622;731445;745141;746665;749337;50650.24024639634;50709.23936140961;51029.23456148161;51059.74470127626;51164.74417627888;1109.0517607445518;1147.8335641331794;1200.6818193178815;1205.3189947679532;1206.6741979665442;28314.85842570774;30403.54394684037;30700.84649576827;31060.22349441282;31235.687643124187;46490.83772905569;47290.76354618205;47299.290510643055;47306.29040564325;47445.288320674525;360214;361016;361714;364339;364739;25112.12107576226;25513.489730205663;26006.479870402865;26013.73986260113;26025.479490409707;40940.38589421221;41171.58828411678;41537.792311038254;41659.1668166641;42371;35583.82208088943;35699.28601427905;36733.26533469369;37678.62321376861;37854;35899.28201435904;36195.27609447849;36712;37026.44460333151;37270.813645931594;35283.82358088193;35548.28903421969;36054.27891442104;36200;36460.270794583426;30352.392952141276;32330;32750.34499310048;32820.179495512806;33025;24925;25153.49693006093;25388.11065799206;25449.61825572655;25584 01:24:28 INFO - PROCESS | 24225 | |2;jquery.html;344.33371426290114;361.5607037449498;370.4813261433992;372.6031776158392;389.4975481628699;12770.616881493559;16149;16746.246418911134;17422.651546969053;17590.384336548224;16679.49961501154;16684.165791710428;17246.39637612684;17762.73355899659;17920.283188672438;4958.231474121517;5119.1809310510325;5134.25553294772;5138.075146473633;5154.252633368159;3729.9067523311996;5160.56135228506;5249.291345668324;5745.798897038604;6027.638341699512;6073.240844894388;6076.665783381913;6099.7865074722395;6104.236970378703;6107.7556897724035;6019.879602407949;6025.179856115113;6115.541334399938;6134.4172303631085;6147.139400483936;5189.714565698885;5374.758135883894;5376.892462150774;5381.81163659274;5384.91922621161;21056.157753689986;21422.78577214239;21440.57118857614;21525.24661636851;21678.566428671496;2011.9295824646213;2129.5634394948997;2471.653968444419;2499.7125330587032;2524.936876578082;9345.672901448417;9621.615135394575;11924.642260732191;13080.103385009215;13116;1772.0962309222389;1783.3847322673657;1789.0875653416722;1791.2118667786262;1805.521536792751;66655.66672166657;74979.25020749723;75162.62418687926;76844.23155768427;76890;9733.615264260301;9764.170045546209;9906.455144966953;10131.64539241123;10197.490125493843;13784.793228101587;13812.37844297009;13816.447342106405;13828.792568111487;13829.51596694111;7382.815429614196;7495.625218739041;7556.206598307209;7649.694012239559;7685.308322250912;7265.8546829063125;7326.377257933029;7349.30181632744;7485.214052524516;7509.66206520697;4296.699231053859;4310.827566897289;4317.11499142675;4368.4321038264825;4411.426514553087;1779.510634575502;1823.334482913727;1830.213008406398;1837.109002133964;1838.8896666200071;808.3735105293327;810.6676262732251;884.6461415433878;900.3112618846587;935;16770.74843877343;16781.7217299222;17320.566985825455;17871.463856084338;17882.463526094238;818.9262966333058;833.9082700902895;835.703325319515;840.5125027484045;915.4370062411568;9552.474613896302;9620.567074481665;10434.113100386552;10467.110295624805;10803.081738052353;399588;408100;408194;410061;410414;81797.18202817896;81974.59012704898;82184;82826;83384.58307708544;879.445949052093;905.3707673167218;924.3483344242293;928.6842473559022;932.9300302477342;15721.68556628884;15767.817413693789;16205.432809851598;16563.42028029013;16938.91530542389;37951.62048379481;38909.61090389173;39210.411843822934;39251;40260.3960940592;53600.73199633977;54818.17772733492;54820.72589637026;55368;55973.16040259318;4848.854534363974;5072.264521644267;7058.188308344606;7951.4433989622485;7971.1630278819885;11140.777184456427;11919.284842909454;12132.332721700392;12246.938765306117;12257.14200005991;9095.499747513686;10313.484325783831;10371.896281037092;10404.47977601132;10785.083267922315;10099.7475063124;10387.896121038995;10417.270791044553;10704.946475267574;10720.571177152826;10168.389896606228;10643.574257029943;10665.733356665834;10873.456327183767;11154.16343774204;7233.276672332935;7728.149903510497;7919.722809701633;7964.601769911365;8313.875291870747;8196.590170491332;9607.56765945548;10089;10300.330478518872;10621.787564248518 01:24:28 INFO - PROCESS | 24225 | |3;mootools.html;1267.7337759070595;1379.358598251813;1404.6067101211659;1461.7403190884327;1685.266908894631;6772.187337519492;7545.509541879781;7870.960645196766;7879.290863822262;8114.472559283658;7926.167752386003;7978.880316795238;7985.8802117968135;7987.241212084858;7989.880151797728;2152.1499007891875;2176.9985806529016;2177.738671359431;2180.051677520276;2180.356794745554;1960.725498430221;2029.6346657601625;2049.3646969439446;2050.3336415664894;2050.41563154501;2125.4580082079046;2147.366526874568;2148.5058436559602;2152.881591512466;2156.5255643758346;2091.602595506849;2097.2345094040716;2097.4336929029228;2101.0965284927474;2103.347962131744;2017.7881322461078;2097.328854766475;2097.5699981503753;2100.096958307927;2102.57948410317;7701.383889288843;7903.209679032108;7968.960155199187;7995.840083198304;8030.196980301981;4501.347304640842;4702.200625893606;4713.457952335457;4715.834945776881;4723.456802467692;2879.8848046078133;2956.541736030919;3001.5347621118763;3002.1593953693;3009.0521485731924;935.2704890185666;938.3712912348675;940.5438362394233;947.6446332625266;958.5782255807422;10573.682789516326;10657.253992220547;10659.680209593724;10680.46597670121;10687.251892367538;4035.1122752994293;4050.959490405058;4083.244599749056;4137.668986481074;4183.247015537232;8511.191436813493;8525.531095789791;8527.104654011364;8527.914720852712;8538.402311838236;4577.473590537064;4582.427196600425;4587.220172570671;4588.426446694163;4593.402857628487;3710.703143748494;4162.105147393325;4283.528811830696;4286.314189729691;4301.07526881722;3431.1765176357994;3434.21013166973;3510.754247202671;3540.91147721309;3541.327147841902;1005.1606908231562;1053.889341619119;1063.6968463987725;1064.3932958213743;1070.4487189097622;704.503325155764;790.9011373578303;806.2703253555542;819.1439945257221;832.5337810825957;5191.428942816287;5225.790968361299;5251.842444726664;5363.678179309254;5496.80761173357;390.837802312043;391.9235749028912;394.8085178688334;415.79418187997135;415.8960259935016;3676.5771936227143;3728.906777330534;3758.624137586274;3773.7735735855385;3812.599677033927;9244.445333280024;9556.187724043395;9641.325107242426;9792.363496372713;9828.066333698287;9663.067386522724;9668.114717629995;9676.12914837654;9677.177439917687;9680.661176858917;7088.149422069385;7186.425085993213;7219.0976127984;7249.637518124073;7276.563406195645;5196.870078248074;5217.426083130928;5338.796721966789;5345.572354211731;5394.9460505394445;8883.289336852908;8922.152395522415;8970.820583588422;9035.683751068682;9054.185123338932;9016.413933094327;9044.683436079706;9144.634214631606;9196.540172991457;9255.583498742439;5735.627184233012;6304.369563043659;6511.869762604816;6598.406143447113;6602.372774586406;7451.515651482853;7629.465937384552;7679.116901556393;7702.268284512962;7705.807354816175;6807.455403567802;6829.897551536632;6929.826754331182;6956.373926346653;7175.425965922818;6686.9331306688255;6746.69639866217;6796.082528858541;6814.965925170342;6831.316868313129;6147.692615369124;6153.784617538365;6213.37866213375;6214.285357183981;6217.285012223652;4527.637788976808;4540.772961351985;4606.378138951199;4705.7647117644665;4715.6699031068865;4511.70673906195;4603.263477843529;4711.31685905535;4765.451973023008;4774.307725379731 01:24:28 INFO - PROCESS | 24225 | |4;prototype.html;284.5305246343533;296.74035219183213;303.6098613281933;305.4212267752607;306.63816696298375;4870.634702397317;4901.509849015097;4907.6810007349495;4910.852674419769;4911.312416261726;4807.375041244633;4808.471068182497;4826.814302560311;4875.122477953967;4883.218685010399;3626.4922910792575;3709.647583479565;3750.587435382106;3758.098056466442;3765.152840610868;3671.963280367202;3747;3833.195029043904;3865.6907447404283;3887.4751908492276;3780.546334439871;3786.053486628343;3804.885853424402;3806.838914131189;3828.5214348206473;3586.910327241814;3739.046543131511;3790.0714324990277;3791.2227993261317;3823.0824602095295;3267.803931764102;3274.607047154333;3276.0990727549874;3280.4751239801517;3280.622728386242;4744.122337367564;4754.239321708545;4777.498362671939;4783.569478746895;4785.9521404785855;4270.316749320125;4270.444842170498;4274.551172126944;4278.657707383401;4317.201317756225;4954.7274899880495;5055.797768089272;5055.797768089272;5056.089903817311;5085.74571271435;3528.4001719707453;3548.8288864674855;3555.1823080691584;3564.7326450516316;3577.177249232691;5372.194170874361;5375.220593013991;5402.37872644643;5425.83722488322;5427.538659213971;3474.426719591239;3659.908502287464;3667.0465678923674;3683.894831550524;3685.74199806011;3700.6114357992024;3703.5926048134684;3712.1833196696684;3732.6267373263;3738.513993180869;4263.445752052214;4268.466441694788;4272.786360681954;4284.828606855691;4298.570142985676;4912.361393018885;5118.923216151761;5140.306058682105;5147.124988751922;5148.330717006766;1276.7957126859844;1282.0512820512954;1288.5618889577402;1300.6228193823686;1301.7786976213877;786.7049856303886;806.7579726082151;827.5283088639418;828.6354004238116;830.9958450207831;4382.189294980439;4396.912061758747;4497.168023915586;4543.477500087466;4557.384753058361;5270.4188743376835;5285.520054384701;5286.286351342596;5300.3639563252655;5303.867403314948;4467.821287148543;4524.6380289576755;4535.31970204472;4545.818167273272;4548.658850586219;2662.853543055112;2779.402428477887;2790.776737860966;2802.8738706758245;2807.694422093736;4859.829905953275;4890.119778439844;4900.656954013256;4906.8773280668265;4942.777575009133;5144.356955380577;5361.249425080492;5406.675599464044;5412.188171774186;5415.268938693304;4891.633127515451;4896.706197628154;4896.730679812573;4903.803847846046;4927.482614325444;5265.0259701955265;5272.868178295574;5284.577233821362;5290.25936368901;5292.655977361459;4949.529794669501;5117.718525481134;5126.487351264844;5157.968406318676;5160.690358578498;4864.513548645107;4869.220924652039;4875.146849301429;4875.390576177978;4879.95120048795;3686.5391826021746;3697.35296323137;3698.3527882619896;3747.119426934614;3749.3626083566405;5013.573846223112;5310.628256022042;5312.203169524448;5323.920141197807;5333.573314134937;5169.017886601534;5170.1727723564045;5171.534561889448;5174.120399532164;5186.974065129651;5142.460041695717;5153.917677287662;5169.922451163311;5189.714565698923;5192.9740351298005;4849.854504364875;5026.346574945233;5145.845624631267;5154.845354639367;5154.845354639367;4913.06651736169;4981.576565991786;5108.897822043613;5143.8456846294675;5151.356080489939;5040.14317566022;5040.546350828443;5046.394432668103;5047.848564543069;5106.897862042664 01:24:28 INFO - PROCESS | 24225 | |5;yui.html;602.1825396825396;614.7878981751294;657.4280376072817;663.8008597420773;729.1032030602357;11657.533698652054;11961.342126183079;11976.880231197685;11981.101417393698;11995.700107497318;12647.114701970866;12778;12822.166559173671;12822.422990965406;12859.099863009593;633.0662273147117;759.6012093650822;769.3614300130891;787.3307688464788;788.0936922539069;767.2595944913157;767.5394763142126;769.3153093746542;770.2913319745819;771.8070482379405;833.0170398929291;833.1002517281352;835.0855812884912;835.1606635331514;835.9205875441854;664.110092476082;793.4842352470882;818.4516374029355;821.6631181215703;823.5758584329076;605.5337390209514;607.8662694207268;608.2974164839617;608.3308360803126;608.4068033667183;11789;11833.763324733458;11844.466998985066;11866.288022718665;11867.347295898722;12455.75088498234;12709.110362274645;12719.618411447671;12978.221306721627;13231.933840330737;9828.312018158731;11547.422628868608;11604.535818567247;11758.17692761507;12239.755204895851;4081.306177949726;4132.690048246393;4150.709450338478;4195.160967806421;4253.659707223445;60680.69659651718;62237;62449;63403.36596634021;64100.35899640991;10126.088652021206;10154.325442049654;10322.535485903152;10346.689599312032;10402.687919362432;18014;18033.639327213645;18040;18058.729119063224;18060.90969545144;6527.5430719849155;6602.636854972927;6614.239362473281;6762.932370676329;6772.93227067723;3471.739619528495;3548.8580456781438;3678.9816050919576;3746.119661879456;3759.49246851677;2803.719628037221;2858.957115643267;2866.7706583473273;2876.194665493665;2879.7120287971034;497.75609951124414;502.703404991057;511.64696359511817;517.8679436743606;524.2764984321688;405.37774516117616;533.3201159822588;542.6798189068469;570.8715539003691;572.928383952006;7291.416686665054;7419.332260096618;7452.925470745223;7696.268854458817;7762.184970578008;376.9302679004393;404.8866317431124;461.0226320201195;519.3015394294667;519.7764961066702;3786.2238241160494;3841.654251117413;4113;4233.97883010583;4310.504292006397;92233;104206.47896760468;105523;108825.45587272014;108981.45509272403;80461.59769201117;83089;84448.57775711206;87124.38626841205;99016.5049174764;43449.34825977613;45245.77377113093;70678;70985.25640064185;72979;8098.271155596025;8110.918890811016;8266.917330826614;8355.665773369241;8729.956350218208;42200.1559968805;43556;44980.32529511995;45081;45759.77120114378;62542;65288.67355663381;65862;65934.67032664806;67222;11108.44457777124;11283.943580282046;11534.077273818242;11673.182877198855;11846.11154163424;12570;12654.177478463871;13432.462701491831;13559;13685.863141368856;11551.826722599335;11719.707007324885;12026.879731202926;12099.57651482194;12785.552505662628;12096.576619818265;12760.361981901053;12791.872081279069;12865.935670321589;13084.58551409754;11743.236689615489;11903.285802851857;12183.208091474025;12508.687282817638;12560.246385216917;8835.160659737314;8896.555172241233;8915.643374265217;9205.815883682422;9482.57328420209;9406.95296523513;10054.396736195851;10439.53022114022;10563.260571760211;10579.682609521727 01:24:28 INFO - PROCESS | 24225 | __end_tp_report 01:24:28 INFO - PROCESS | 24225 | __start_cc_report 01:24:28 INFO - PROCESS | 24225 | _x_x_mozilla_cycle_collect,1183 01:24:28 INFO - PROCESS | 24225 | __end_cc_report 01:24:28 INFO - PROCESS | 24225 | __startTimestamp1469435068777__endTimestamp 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | ------- Summary: start ------- 01:24:28 INFO - PROCESS | 24225 | Number of tests: 6 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | [#0] dojo.html Cycles:165 Average:4767.35 Median:4877.07 stddev:512.16 (10.5%) stddev-sans-first:483.62 01:24:28 INFO - PROCESS | 24225 | Values: 2561.6 2595.4 2598.2 2602.8 2647.7 4667.5 4745.6 4784.2 4819.1 4829.4 4790.7 4791.9 4840.9 4865.2 4873.1 4388.0 4421.4 4441.1 4492.8 4515.9 4434.9 4536.4 4560.1 4568.7 4593.3 4492.0 4530.4 4547.9 4573.7 4593.5 4354.6 4364.4 4405.2 4406.5 4417.6 4347.3 4389.4 4421.0 4443.2 4484.0 4786.1 4793.5 4838.5 4842.4 4898.3 4897.8 5062.8 5091.0 5115.6 5157.9 5151.8 5207.9 5208.9 5217.8 5221.0 4841.0 4851.3 4879.7 4886.7 4937.5 5163.9 5260.3 5273.4 5309.9 5393.5 5134.8 5153.6 5160.9 5162.2 5162.3 5216.5 5222.5 5261.3 5269.6 5271.3 4958.6 5074.0 5147.1 5151.8 5152.6 5037.7 5098.0 5107.3 5145.3 5146.8 4388.2 4401.4 4402.8 4403.1 4440.0 3791.0 3802.9 3803.8 3869.4 3871.4 4376.4 4414.0 4416.1 4450.6 4466.8 5136.7 5138.5 5147.2 5183.6 5191.5 4410.1 4414.1 4421.2 4457.8 4465.5 4503.1 4531.3 4546.2 4567.1 4573.6 4814.1 4828.5 4829.0 4866.6 4877.1 5161.0 5171.8 5176.5 5178.9 5215.3 4653.9 4755.2 4809.4 4813.0 4870.8 5113.7 5123.3 5131.7 5149.4 5180.9 5182.6 5195.7 5195.9 5197.0 5249.1 4846.2 4926.5 4974.0 5054.5 5068.5 5003.9 5038.9 5043.0 5080.9 5097.8 4966.6 5016.1 5018.3 5027.2 5027.8 4879.2 4957.4 4970.1 5055.2 5080.4 4876.4 4935.5 4941.3 4961.3 4981.1 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | [#1] ext.html Cycles:180 Average:55944.13 Median:3657.90 stddev:127886.95 (3496.2%) stddev-sans-first:128178.13 01:24:28 INFO - PROCESS | 24225 | Values: 570.8 576.7 580.1 588.0 597.7 27520.7 38959.6 39871.4 39917.0 43668.8 40469.2 40916.8 40932.2 40954.4 40977.2 7561.5 7702.5 7704.3 7705.7 7705.8 7679.8 7706.2 7743.8 7758.9 7759.5 7769.4 7816.8 7829.7 7831.0 7841.6 7740.3 7778.9 7779.1 7783.7 7785.9 7635.4 7699.9 7702.8 7714.7 7717.8 37701.0 37882.4 38040.2 38162.6 38228.2 2859.6 3060.7 3242.3 3683.5 3696.3 28982.1 29396.3 29403.4 29526.9 29542.0 3518.6 3601.6 3650.0 3665.8 3710.8 258313.0 258524.0 258717.7 259015.0 259994.0 32046.7 32795.7 52954.0 53217.5 53484.5 33467.8 33547.7 33699.2 33701.7 33706.8 13595.3 13713.5 13714.7 13717.9 13728.8 11302.0 11402.8 11432.7 11433.2 11492.7 7844.9 7869.1 7882.3 7916.1 7957.3 3095.1 3098.1 3105.9 3115.7 3126.2 832.3 874.8 884.9 920.0 1007.1 27683.3 28129.7 28143.7 28147.0 28744.9 829.5 952.7 986.3 1014.2 1024.0 14663.0 15119.0 15309.8 15581.0 15665.0 410622.0 731445.0 745141.0 746665.0 749337.0 50650.2 50709.2 51029.2 51059.7 51164.7 1109.1 1147.8 1200.7 1205.3 1206.7 28314.9 30403.5 30700.8 31060.2 31235.7 46490.8 47290.8 47299.3 47306.3 47445.3 360214.0 361016.0 361714.0 364339.0 364739.0 25112.1 25513.5 26006.5 26013.7 26025.5 40940.4 41171.6 41537.8 41659.2 42371.0 35583.8 35699.3 36733.3 37678.6 37854.0 35899.3 36195.3 36712.0 37026.4 37270.8 35283.8 35548.3 36054.3 36200.0 36460.3 30352.4 32330.0 32750.3 32820.2 33025.0 24925.0 25153.5 25388.1 25449.6 25584.0 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | [#2] jquery.html Cycles:180 Average:25418.94 Median:207355.35 stddev:67385.49 (32.5%) stddev-sans-first:67548.23 01:24:28 INFO - PROCESS | 24225 | Values: 344.3 361.6 370.5 372.6 389.5 12770.6 16149.0 16746.2 17422.7 17590.4 16679.5 16684.2 17246.4 17762.7 17920.3 4958.2 5119.2 5134.3 5138.1 5154.3 3729.9 5160.6 5249.3 5745.8 6027.6 6073.2 6076.7 6099.8 6104.2 6107.8 6019.9 6025.2 6115.5 6134.4 6147.1 5189.7 5374.8 5376.9 5381.8 5384.9 21056.2 21422.8 21440.6 21525.2 21678.6 2011.9 2129.6 2471.7 2499.7 2524.9 9345.7 9621.6 11924.6 13080.1 13116.0 1772.1 1783.4 1789.1 1791.2 1805.5 66655.7 74979.3 75162.6 76844.2 76890.0 9733.6 9764.2 9906.5 10131.6 10197.5 13784.8 13812.4 13816.4 13828.8 13829.5 7382.8 7495.6 7556.2 7649.7 7685.3 7265.9 7326.4 7349.3 7485.2 7509.7 4296.7 4310.8 4317.1 4368.4 4411.4 1779.5 1823.3 1830.2 1837.1 1838.9 808.4 810.7 884.6 900.3 935.0 16770.7 16781.7 17320.6 17871.5 17882.5 818.9 833.9 835.7 840.5 915.4 9552.5 9620.6 10434.1 10467.1 10803.1 399588.0 408100.0 408194.0 410061.0 410414.0 81797.2 81974.6 82184.0 82826.0 83384.6 879.4 905.4 924.3 928.7 932.9 15721.7 15767.8 16205.4 16563.4 16938.9 37951.6 38909.6 39210.4 39251.0 40260.4 53600.7 54818.2 54820.7 55368.0 55973.2 4848.9 5072.3 7058.2 7951.4 7971.2 11140.8 11919.3 12132.3 12246.9 12257.1 9095.5 10313.5 10371.9 10404.5 10785.1 10099.7 10387.9 10417.3 10704.9 10720.6 10168.4 10643.6 10665.7 10873.5 11154.2 7233.3 7728.1 7919.7 7964.6 8313.9 8196.6 9607.6 10089.0 10300.3 10621.8 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | [#3] mootools.html Cycles:180 Average:5109.99 Median:5194.15 stddev:2906.44 (56.0%) stddev-sans-first:2900.25 01:24:28 INFO - PROCESS | 24225 | Values: 1267.7 1379.4 1404.6 1461.7 1685.3 6772.2 7545.5 7871.0 7879.3 8114.5 7926.2 7978.9 7985.9 7987.2 7989.9 2152.1 2177.0 2177.7 2180.1 2180.4 1960.7 2029.6 2049.4 2050.3 2050.4 2125.5 2147.4 2148.5 2152.9 2156.5 2091.6 2097.2 2097.4 2101.1 2103.3 2017.8 2097.3 2097.6 2100.1 2102.6 7701.4 7903.2 7969.0 7995.8 8030.2 4501.3 4702.2 4713.5 4715.8 4723.5 2879.9 2956.5 3001.5 3002.2 3009.1 935.3 938.4 940.5 947.6 958.6 10573.7 10657.3 10659.7 10680.5 10687.3 4035.1 4051.0 4083.2 4137.7 4183.2 8511.2 8525.5 8527.1 8527.9 8538.4 4577.5 4582.4 4587.2 4588.4 4593.4 3710.7 4162.1 4283.5 4286.3 4301.1 3431.2 3434.2 3510.8 3540.9 3541.3 1005.2 1053.9 1063.7 1064.4 1070.4 704.5 790.9 806.3 819.1 832.5 5191.4 5225.8 5251.8 5363.7 5496.8 390.8 391.9 394.8 415.8 415.9 3676.6 3728.9 3758.6 3773.8 3812.6 9244.4 9556.2 9641.3 9792.4 9828.1 9663.1 9668.1 9676.1 9677.2 9680.7 7088.1 7186.4 7219.1 7249.6 7276.6 5196.9 5217.4 5338.8 5345.6 5394.9 8883.3 8922.2 8970.8 9035.7 9054.2 9016.4 9044.7 9144.6 9196.5 9255.6 5735.6 6304.4 6511.9 6598.4 6602.4 7451.5 7629.5 7679.1 7702.3 7705.8 6807.5 6829.9 6929.8 6956.4 7175.4 6686.9 6746.7 6796.1 6815.0 6831.3 6147.7 6153.8 6213.4 6214.3 6217.3 4527.6 4540.8 4606.4 4705.8 4715.7 4511.7 4603.3 4711.3 4765.5 4774.3 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | [#4] prototype.html Cycles:180 Average:4228.62 Median:4866.87 stddev:1246.14 (25.6%) stddev-sans-first:1213.96 01:24:28 INFO - PROCESS | 24225 | Values: 284.5 296.7 303.6 305.4 306.6 4870.6 4901.5 4907.7 4910.9 4911.3 4807.4 4808.5 4826.8 4875.1 4883.2 3626.5 3709.6 3750.6 3758.1 3765.2 3672.0 3747.0 3833.2 3865.7 3887.5 3780.5 3786.1 3804.9 3806.8 3828.5 3586.9 3739.0 3790.1 3791.2 3823.1 3267.8 3274.6 3276.1 3280.5 3280.6 4744.1 4754.2 4777.5 4783.6 4786.0 4270.3 4270.4 4274.6 4278.7 4317.2 4954.7 5055.8 5055.8 5056.1 5085.7 3528.4 3548.8 3555.2 3564.7 3577.2 5372.2 5375.2 5402.4 5425.8 5427.5 3474.4 3659.9 3667.0 3683.9 3685.7 3700.6 3703.6 3712.2 3732.6 3738.5 4263.4 4268.5 4272.8 4284.8 4298.6 4912.4 5118.9 5140.3 5147.1 5148.3 1276.8 1282.1 1288.6 1300.6 1301.8 786.7 806.8 827.5 828.6 831.0 4382.2 4396.9 4497.2 4543.5 4557.4 5270.4 5285.5 5286.3 5300.4 5303.9 4467.8 4524.6 4535.3 4545.8 4548.7 2662.9 2779.4 2790.8 2802.9 2807.7 4859.8 4890.1 4900.7 4906.9 4942.8 5144.4 5361.2 5406.7 5412.2 5415.3 4891.6 4896.7 4896.7 4903.8 4927.5 5265.0 5272.9 5284.6 5290.3 5292.7 4949.5 5117.7 5126.5 5158.0 5160.7 4864.5 4869.2 4875.1 4875.4 4880.0 3686.5 3697.4 3698.4 3747.1 3749.4 5013.6 5310.6 5312.2 5323.9 5333.6 5169.0 5170.2 5171.5 5174.1 5187.0 5142.5 5153.9 5169.9 5189.7 5193.0 4849.9 5026.3 5145.8 5154.8 5154.8 4913.1 4981.6 5108.9 5143.8 5151.4 5040.1 5040.5 5046.4 5047.8 5106.9 01:24:28 INFO - PROCESS | 24225 | 01:24:28 INFO - PROCESS | 24225 | [#5] yui.html Cycles:180 Average:17687.69 Median:23879.93 stddev:25636.26 (107.4%) stddev-sans-first:25676.08 01:24:28 INFO - PROCESS | 24225 | Values: 602.2 614.8 657.4 663.8 729.1 11657.5 11961.3 11976.9 11981.1 11995.7 12647.1 12778.0 12822.2 12822.4 12859.1 633.1 759.6 769.4 787.3 788.1 767.3 767.5 769.3 770.3 771.8 833.0 833.1 835.1 835.2 835.9 664.1 793.5 818.5 821.7 823.6 605.5 607.9 608.3 608.3 608.4 11789.0 11833.8 11844.5 11866.3 11867.3 12455.8 12709.1 12719.6 12978.2 13231.9 9828.3 11547.4 11604.5 11758.2 12239.8 4081.3 4132.7 4150.7 4195.2 4253.7 60680.7 62237.0 62449.0 63403.4 64100.4 10126.1 10154.3 10322.5 10346.7 10402.7 18014.0 18033.6 18040.0 18058.7 18060.9 6527.5 6602.6 6614.2 6762.9 6772.9 3471.7 3548.9 3679.0 3746.1 3759.5 2803.7 2859.0 2866.8 2876.2 2879.7 497.8 502.7 511.6 517.9 524.3 405.4 533.3 542.7 570.9 572.9 7291.4 7419.3 7452.9 7696.3 7762.2 376.9 404.9 461.0 519.3 519.8 3786.2 3841.7 4113.0 4234.0 4310.5 92233.0 104206.5 105523.0 108825.5 108981.5 80461.6 83089.0 84448.6 87124.4 99016.5 43449.3 45245.8 70678.0 70985.3 72979.0 8098.3 8110.9 8266.9 8355.7 8730.0 42200.2 43556.0 44980.3 45081.0 45759.8 62542.0 65288.7 65862.0 65934.7 67222.0 11108.4 11283.9 11534.1 11673.2 11846.1 12570.0 12654.2 13432.5 13559.0 13685.9 11551.8 11719.7 12026.9 12099.6 12785.6 12096.6 12760.4 12791.9 12865.9 13084.6 11743.2 11903.3 12183.2 12508.7 12560.2 8835.2 8896.6 8915.6 9205.8 9482.6 9407.0 10054.4 10439.5 10563.3 10579.7 01:24:28 INFO - PROCESS | 24225 | -------- Summary: end -------- 01:24:28 INFO - PROCESS | 24225 | 01:24:29 INFO - TEST-INFO | 24225: exit 0 01:24:29 INFO - TEST-OK | dromaeo_css | took 1119639ms 01:24:29 INFO - TEST-START | kraken 01:24:29 INFO - operating with platform_type : linux_ 01:24:29 INFO - Initialising browser for kraken test... 01:24:29 INFO - TEST-INFO | started process 24416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7jil1E/profile http://localhost:48702/getInfo.html) 01:24:32 INFO - PROCESS | 24416 | JavaScript error: , line 0: uncaught exception: undefined 01:24:33 INFO - PROCESS | 24416 | __metrics Screen width/height:1600/1200 01:24:33 INFO - PROCESS | 24416 | colorDepth:24 01:24:33 INFO - PROCESS | 24416 | Browser inner width/height: 1024/697 01:24:33 INFO - PROCESS | 24416 | __metrics 01:24:34 INFO - PROCESS | 24416 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:24:34 INFO - PROCESS | 24416 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:24:35 INFO - TEST-INFO | 24416: exit 0 01:24:35 INFO - Browser initialized. 01:24:35 INFO - Running cycle 1/1 for kraken test... 01:24:35 INFO - TEST-INFO | started process 24496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7jil1E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:24:47 INFO - PROCESS | 24496 | RSS: Main: 158994432 01:24:47 INFO - PROCESS | 24496 | 01:24:49 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48702/tests/kraken/driver.html?testName=audio-beat-detection) 01:24:50 INFO - PROCESS | 24496 | RSS: Main: 215441408 01:24:50 INFO - PROCESS | 24496 | 01:24:53 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48702/tests/kraken/driver.html?testName=audio-dft) 01:24:54 INFO - PROCESS | 24496 | RSS: Main: 193048576 01:24:54 INFO - PROCESS | 24496 | 01:24:57 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48702/tests/kraken/driver.html?testName=audio-fft) 01:24:58 INFO - PROCESS | 24496 | RSS: Main: 272928768 01:24:58 INFO - PROCESS | 24496 | 01:25:00 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48702/tests/kraken/driver.html?testName=audio-oscillator) 01:25:00 INFO - PROCESS | 24496 | RSS: Main: 181694464 01:25:00 INFO - PROCESS | 24496 | 01:25:03 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:25:03 INFO - PROCESS | 24496 | RSS: Main: 186265600 01:25:03 INFO - PROCESS | 24496 | 01:25:06 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48702/tests/kraken/driver.html?testName=imaging-darkroom) 01:25:07 INFO - PROCESS | 24496 | RSS: Main: 222396416 01:25:07 INFO - PROCESS | 24496 | 01:25:10 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48702/tests/kraken/driver.html?testName=imaging-desaturate) 01:25:11 INFO - PROCESS | 24496 | RSS: Main: 222543872 01:25:11 INFO - PROCESS | 24496 | 01:25:14 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48702/tests/kraken/driver.html?testName=json-parse-financial) 01:25:15 INFO - PROCESS | 24496 | RSS: Main: 221921280 01:25:15 INFO - PROCESS | 24496 | 01:25:16 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:25:17 INFO - PROCESS | 24496 | RSS: Main: 186626048 01:25:17 INFO - PROCESS | 24496 | 01:25:19 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:25:19 INFO - PROCESS | 24496 | RSS: Main: 191012864 01:25:19 INFO - PROCESS | 24496 | 01:25:21 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:25:22 INFO - PROCESS | 24496 | RSS: Main: 195629056 01:25:22 INFO - PROCESS | 24496 | 01:25:25 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:25:26 INFO - PROCESS | 24496 | RSS: Main: 191688704 01:25:26 INFO - PROCESS | 24496 | 01:25:28 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:25:29 INFO - PROCESS | 24496 | RSS: Main: 194355200 01:25:29 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | Cycle 1(1): loaded http://localhost:48702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48702/tests/kraken/driver.html?testName=ai-astar) 01:25:31 INFO - PROCESS | 24496 | RSS: Main: 245075968 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | __start_tp_report 01:25:31 INFO - PROCESS | 24496 | _x_x_mozilla_page_load 01:25:31 INFO - PROCESS | 24496 | _x_x_mozilla_page_load_details 01:25:31 INFO - PROCESS | 24496 | |i|pagename|runs| 01:25:31 INFO - PROCESS | 24496 | |0;ai-astar;105;114;114;113;113;114;116;113;113;115 01:25:31 INFO - PROCESS | 24496 | |1;audio-beat-detection;154;123;123;182;122;127;147;122;167;122 01:25:31 INFO - PROCESS | 24496 | |2;audio-dft;161;160;160;161;162;161;160;161;160;163 01:25:31 INFO - PROCESS | 24496 | |3;audio-fft;74;76;75;119;87;78;75;76;101;77 01:25:31 INFO - PROCESS | 24496 | |4;audio-oscillator;85;87;115;86;85;86;112;85;85;120 01:25:31 INFO - PROCESS | 24496 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;116;117 01:25:31 INFO - PROCESS | 24496 | |6;imaging-darkroom;147;147;147;146;147;147;146;146;146;146 01:25:31 INFO - PROCESS | 24496 | |7;imaging-desaturate;95;94;95;96;95;95;96;95;95;95 01:25:31 INFO - PROCESS | 24496 | |8;json-parse-financial;62;61;62;62;61;62;62;62;61;61 01:25:31 INFO - PROCESS | 24496 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;65;67 01:25:31 INFO - PROCESS | 24496 | |10;stanford-crypto-aes;79;79;80;81;79;80;80;81;80;93 01:25:31 INFO - PROCESS | 24496 | |11;stanford-crypto-ccm;136;131;130;131;136;138;134;130;168;130 01:25:31 INFO - PROCESS | 24496 | |12;stanford-crypto-pbkdf2;166;164;168;166;168;170;161;160;165;162 01:25:31 INFO - PROCESS | 24496 | |13;stanford-crypto-sha256-iterative;66;70;67;66;66;67;66;65;66;65 01:25:31 INFO - PROCESS | 24496 | __end_tp_report 01:25:31 INFO - PROCESS | 24496 | __start_cc_report 01:25:31 INFO - PROCESS | 24496 | _x_x_mozilla_cycle_collect,1948 01:25:31 INFO - PROCESS | 24496 | __end_cc_report 01:25:31 INFO - PROCESS | 24496 | __startTimestamp1469435131542__endTimestamp 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | ------- Summary: start ------- 01:25:31 INFO - PROCESS | 24496 | Number of tests: 14 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 01:25:31 INFO - PROCESS | 24496 | Values: 105.0 114.0 114.0 113.0 113.0 114.0 116.0 113.0 113.0 115.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:137.00 stddev:22.22 (16.2%) stddev-sans-first:22.89 01:25:31 INFO - PROCESS | 24496 | Values: 154.0 123.0 123.0 182.0 122.0 127.0 147.0 122.0 167.0 122.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 01:25:31 INFO - PROCESS | 24496 | Values: 161.0 160.0 160.0 161.0 162.0 161.0 160.0 161.0 160.0 163.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:14.90 (19.6%) stddev-sans-first:15.37 01:25:31 INFO - PROCESS | 24496 | Values: 74.0 76.0 75.0 119.0 87.0 78.0 75.0 76.0 101.0 77.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:85.00 stddev:14.68 (17.3%) stddev-sans-first:15.15 01:25:31 INFO - PROCESS | 24496 | Values: 85.0 87.0 115.0 86.0 85.0 86.0 112.0 85.0 85.0 120.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 01:25:31 INFO - PROCESS | 24496 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:25:31 INFO - PROCESS | 24496 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 01:25:31 INFO - PROCESS | 24496 | Values: 95.0 94.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:25:31 INFO - PROCESS | 24496 | Values: 62.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 61.0 61.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:25:31 INFO - PROCESS | 24496 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 67.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:4.21 (5.3%) stddev-sans-first:4.39 01:25:31 INFO - PROCESS | 24496 | Values: 79.0 79.0 80.0 81.0 79.0 80.0 80.0 81.0 80.0 93.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:135.00 stddev:11.49 (8.5%) stddev-sans-first:12.19 01:25:31 INFO - PROCESS | 24496 | Values: 136.0 131.0 130.0 131.0 136.0 138.0 134.0 130.0 168.0 130.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.00 stddev:3.27 (2.0%) stddev-sans-first:3.44 01:25:31 INFO - PROCESS | 24496 | Values: 166.0 164.0 168.0 166.0 168.0 170.0 161.0 160.0 165.0 162.0 01:25:31 INFO - PROCESS | 24496 | 01:25:31 INFO - PROCESS | 24496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 01:25:31 INFO - PROCESS | 24496 | Values: 66.0 70.0 67.0 66.0 66.0 67.0 66.0 65.0 66.0 65.0 01:25:31 INFO - PROCESS | 24496 | -------- Summary: end -------- 01:25:31 INFO - PROCESS | 24496 | 01:25:32 INFO - TEST-INFO | 24496: exit 0 01:25:32 INFO - TEST-OK | kraken | took 62917ms 01:25:32 INFO - SUITE-END | took 1182s 01:25:32 INFO - Completed test suite (00:19:42) 01:25:32 INFO - javascript benchmark 01:25:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.6285638582394, 2595.4030572968213, 2598.233521111272, 2602.7787638050777, 2647.6690413698293, 4667.463241727202, 4745.644076694244, 4784.210605250134, 4819.1084649339855, 4829.37218161639, 4790.736509491985, 4791.856244312677, 4840.903181936359, 4865.172920603497, 4873.074115917973, 4388.034632380871, 4421.447319085114, 4441.133978874121, 4492.797824097907, 4515.932261016087, 4434.889127771799, 4536.387587675671, 4560.0879824035155, 4568.748718820463, 4593.333966574844, 4492.011757413364, 4530.388397566319, 4547.8635640930825, 4573.725576465423, 4593.540645935396, 4354.608085272341, 4364.388985542027, 4405.185040767468, 4406.471223453206, 4417.558244175589, 4347.30443129101, 4389.363542286351, 4421.027373977719, 4443.155800397914, 4483.955160448387, 4786.066716990188, 4793.544613261734, 4838.540338667821, 4842.4189097308545, 4898.314236006961, 4897.804087836482, 5062.797488100471, 5091.0, 5115.641905066647, 5157.896842063138, 5151.845444636667, 5207.921881171786, 5208.947910520884, 5217.843464696065, 5221.034108689866, 4841.0, 4851.320815085891, 4879.658423910292, 4886.731229782396, 4937.481564435682, 5163.922541161885, 5260.263563101169, 5273.419923808378, 5309.946900530946, 5393.487618676219, 5134.818991631945, 5153.613478989091, 5160.948390516047, 5162.199859021857, 5162.251473536391, 5216.478352164753, 5222.477752224747, 5261.289725887033, 5269.631125821155, 5271.262023316739, 4958.603311735053, 5074.010567939216, 5147.0992576298995, 5151.793928242903, 5152.613553983466, 5037.748112594356, 5098.031374038921, 5107.284980102714, 5145.253938179018, 5146.768395422215, 4388.188185185751, 4401.383806267125, 4402.757848318373, 4403.053343531156, 4440.0, 3791.014336272589, 3802.9049273767823, 3803.7527560708463, 3869.3808990561374, 3871.399933010388, 4376.387305777193, 4413.955860441354, 4416.094700586372, 4450.577195166454, 4466.798994045275, 5136.743162841918, 5138.511841375063, 5147.2279158126585, 5183.585313174937, 5191.532762051434, 4410.1400226956075, 4414.073044660658, 4421.159979603865, 4457.8216871324785, 4465.531119232433, 4503.054358584734, 4531.297648864432, 4546.158960592301, 4567.086582683477, 4573.611243044378, 4814.085323788469, 4828.468868424541, 4829.034193161311, 4866.635002374836, 4877.073356062337, 5160.974195129001, 5171.844844654666, 5176.50823171798, 5178.8964220716125, 5215.322008138917, 4653.86038418848, 4755.167845627071, 4809.422869255712, 4813.03739252144, 4870.756462176948, 5113.667611605234, 5123.3339665843205, 5131.743412829269, 5149.356330458692, 5180.896382072262, 5182.585393168612, 5195.688258704338, 5195.948040519697, 5197.0, 5249.107651699144, 4846.151923413318, 4926.458089610069, 4974.0, 5054.4692807254705, 5068.518490743373, 5003.874903127451, 5038.949610503848, 5042.974785126051, 5080.949190508048, 5097.796088156432, 4966.577840883565, 5016.072026675077, 5018.347614810052, 5027.2207807789855, 5027.798888044437, 4879.219324908139, 4957.380327459067, 4970.105381031449, 5055.16589762685, 5080.390353157644, 4876.4392094909535, 4935.506449355035, 4941.2835138905375, 4961.330220420197, 4981.053599816023], "value": 4733.158919187511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7745440550982, 576.6540075954426, 580.118220305136, 587.9706014699264, 597.7250464786198, 27520.724792752066, 38959.61040389595, 39871.40192897109, 39917.0, 43668.781656091756, 40469.19061618766, 40916.79541602295, 40932.18135637286, 40954.38568421476, 40977.18045639093, 7561.546307221571, 7702.46082774206, 7704.26809453101, 7705.73029943952, 7705.807354816118, 7679.846403071935, 7706.229377062305, 7743.806404839867, 7758.883616745753, 7759.495632783879, 7769.3784497240085, 7816.843663126734, 7829.6868125275205, 7831.0, 7841.647125879321, 7740.303372696456, 7778.922210777876, 7779.105402878628, 7783.727569535039, 7785.883211751829, 7635.389168866477, 7699.923000770033, 7702.807429814244, 7714.6914123435, 7717.807054823618, 37701.0, 37882.43176352357, 38040.23919521594, 38162.61837381646, 38228.23543529142, 2859.589125840718, 3060.6633270340244, 3242.3353212591364, 3683.4658974448553, 3696.3346597612417, 28982.13053608395, 29396.26509337262, 29403.41193176146, 29526.852365738036, 29542.0, 3518.6129525752403, 3601.621829707869, 3650.0, 3665.7983810890655, 3710.77735335878, 258313.0, 258524.0, 258717.70641146862, 259015.0, 259994.0, 32046.67953320437, 32795.67204327974, 52954.0, 53217.46782532125, 53484.46515534873, 33467.832660837026, 33547.66452335494, 33699.15752106217, 33701.66298336985, 33706.831465842515, 13595.252261125734, 13713.520026799015, 13714.657133571542, 13717.862821371658, 13728.794068088986, 11302.0, 11402.771944561062, 11432.714182145346, 11433.199676022765, 11492.712682182844, 7844.921550784533, 7869.055713314439, 7882.330001949898, 7916.08964969036, 7957.283844454027, 3095.071478556424, 3098.101550550315, 3105.875764969421, 3115.672854350306, 3126.1715645353997, 832.2842355574202, 874.7856775090144, 884.8849649545647, 919.9678011269574, 1007.1036777268237, 27683.307917301827, 28129.71870281271, 28143.71856281452, 28147.0, 28744.856275718488, 829.4774292195877, 952.7284723853669, 986.3440811860177, 1014.1835822163082, 1023.9913685020249, 14663.0, 15119.0, 15309.846901531066, 15581.0, 15665.0, 410622.0, 731445.0, 745141.0, 746665.0, 749337.0, 50650.24024639634, 50709.23936140961, 51029.23456148161, 51059.74470127626, 51164.74417627888, 1109.0517607445518, 1147.8335641331794, 1200.6818193178815, 1205.3189947679532, 1206.6741979665442, 28314.85842570774, 30403.54394684037, 30700.84649576827, 31060.22349441282, 31235.687643124187, 46490.83772905569, 47290.76354618205, 47299.290510643055, 47306.29040564325, 47445.288320674525, 360214.0, 361016.0, 361714.0, 364339.0, 364739.0, 25112.12107576226, 25513.489730205663, 26006.479870402865, 26013.73986260113, 26025.479490409707, 40940.38589421221, 41171.58828411678, 41537.792311038254, 41659.1668166641, 42371.0, 35583.82208088943, 35699.28601427905, 36733.26533469369, 37678.62321376861, 37854.0, 35899.28201435904, 36195.27609447849, 36712.0, 37026.44460333151, 37270.813645931594, 35283.82358088193, 35548.28903421969, 36054.27891442104, 36200.0, 36460.270794583426, 30352.392952141276, 32330.0, 32750.34499310048, 32820.179495512806, 33025.0, 24925.0, 25153.49693006093, 25388.11065799206, 25449.61825572655, 25584.0], "value": 16920.835412464705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.33371426290114, 361.5607037449498, 370.4813261433992, 372.6031776158392, 389.4975481628699, 12770.616881493559, 16149.0, 16746.246418911134, 17422.651546969053, 17590.384336548224, 16679.49961501154, 16684.165791710428, 17246.39637612684, 17762.73355899659, 17920.283188672438, 4958.231474121517, 5119.1809310510325, 5134.25553294772, 5138.075146473633, 5154.252633368159, 3729.9067523311996, 5160.56135228506, 5249.291345668324, 5745.798897038604, 6027.638341699512, 6073.240844894388, 6076.665783381913, 6099.7865074722395, 6104.236970378703, 6107.7556897724035, 6019.879602407949, 6025.179856115113, 6115.541334399938, 6134.4172303631085, 6147.139400483936, 5189.714565698885, 5374.758135883894, 5376.892462150774, 5381.81163659274, 5384.91922621161, 21056.157753689986, 21422.78577214239, 21440.57118857614, 21525.24661636851, 21678.566428671496, 2011.9295824646213, 2129.5634394948997, 2471.653968444419, 2499.7125330587032, 2524.936876578082, 9345.672901448417, 9621.615135394575, 11924.642260732191, 13080.103385009215, 13116.0, 1772.0962309222389, 1783.3847322673657, 1789.0875653416722, 1791.2118667786262, 1805.521536792751, 66655.66672166657, 74979.25020749723, 75162.62418687926, 76844.23155768427, 76890.0, 9733.615264260301, 9764.170045546209, 9906.455144966953, 10131.64539241123, 10197.490125493843, 13784.793228101587, 13812.37844297009, 13816.447342106405, 13828.792568111487, 13829.51596694111, 7382.815429614196, 7495.625218739041, 7556.206598307209, 7649.694012239559, 7685.308322250912, 7265.8546829063125, 7326.377257933029, 7349.30181632744, 7485.214052524516, 7509.66206520697, 4296.699231053859, 4310.827566897289, 4317.11499142675, 4368.4321038264825, 4411.426514553087, 1779.510634575502, 1823.334482913727, 1830.213008406398, 1837.109002133964, 1838.8896666200071, 808.3735105293327, 810.6676262732251, 884.6461415433878, 900.3112618846587, 935.0, 16770.74843877343, 16781.7217299222, 17320.566985825455, 17871.463856084338, 17882.463526094238, 818.9262966333058, 833.9082700902895, 835.703325319515, 840.5125027484045, 915.4370062411568, 9552.474613896302, 9620.567074481665, 10434.113100386552, 10467.110295624805, 10803.081738052353, 399588.0, 408100.0, 408194.0, 410061.0, 410414.0, 81797.18202817896, 81974.59012704898, 82184.0, 82826.0, 83384.58307708544, 879.445949052093, 905.3707673167218, 924.3483344242293, 928.6842473559022, 932.9300302477342, 15721.68556628884, 15767.817413693789, 16205.432809851598, 16563.42028029013, 16938.91530542389, 37951.62048379481, 38909.61090389173, 39210.411843822934, 39251.0, 40260.3960940592, 53600.73199633977, 54818.17772733492, 54820.72589637026, 55368.0, 55973.16040259318, 4848.854534363974, 5072.264521644267, 7058.188308344606, 7951.4433989622485, 7971.1630278819885, 11140.777184456427, 11919.284842909454, 12132.332721700392, 12246.938765306117, 12257.14200005991, 9095.499747513686, 10313.484325783831, 10371.896281037092, 10404.47977601132, 10785.083267922315, 10099.7475063124, 10387.896121038995, 10417.270791044553, 10704.946475267574, 10720.571177152826, 10168.389896606228, 10643.574257029943, 10665.733356665834, 10873.456327183767, 11154.16343774204, 7233.276672332935, 7728.149903510497, 7919.722809701633, 7964.601769911365, 8313.875291870747, 8196.590170491332, 9607.56765945548, 10089.0, 10300.330478518872, 10621.787564248518], "value": 8452.782315964405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.7337759070595, 1379.358598251813, 1404.6067101211659, 1461.7403190884327, 1685.266908894631, 6772.187337519492, 7545.509541879781, 7870.960645196766, 7879.290863822262, 8114.472559283658, 7926.167752386003, 7978.880316795238, 7985.8802117968135, 7987.241212084858, 7989.880151797728, 2152.1499007891875, 2176.9985806529016, 2177.738671359431, 2180.051677520276, 2180.356794745554, 1960.725498430221, 2029.6346657601625, 2049.3646969439446, 2050.3336415664894, 2050.41563154501, 2125.4580082079046, 2147.366526874568, 2148.5058436559602, 2152.881591512466, 2156.5255643758346, 2091.602595506849, 2097.2345094040716, 2097.4336929029228, 2101.0965284927474, 2103.347962131744, 2017.7881322461078, 2097.328854766475, 2097.5699981503753, 2100.096958307927, 2102.57948410317, 7701.383889288843, 7903.209679032108, 7968.960155199187, 7995.840083198304, 8030.196980301981, 4501.347304640842, 4702.200625893606, 4713.457952335457, 4715.834945776881, 4723.456802467692, 2879.8848046078133, 2956.541736030919, 3001.5347621118763, 3002.1593953693, 3009.0521485731924, 935.2704890185666, 938.3712912348675, 940.5438362394233, 947.6446332625266, 958.5782255807422, 10573.682789516326, 10657.253992220547, 10659.680209593724, 10680.46597670121, 10687.251892367538, 4035.1122752994293, 4050.959490405058, 4083.244599749056, 4137.668986481074, 4183.247015537232, 8511.191436813493, 8525.531095789791, 8527.104654011364, 8527.914720852712, 8538.402311838236, 4577.473590537064, 4582.427196600425, 4587.220172570671, 4588.426446694163, 4593.402857628487, 3710.703143748494, 4162.105147393325, 4283.528811830696, 4286.314189729691, 4301.07526881722, 3431.1765176357994, 3434.21013166973, 3510.754247202671, 3540.91147721309, 3541.327147841902, 1005.1606908231562, 1053.889341619119, 1063.6968463987725, 1064.3932958213743, 1070.4487189097622, 704.503325155764, 790.9011373578303, 806.2703253555542, 819.1439945257221, 832.5337810825957, 5191.428942816287, 5225.790968361299, 5251.842444726664, 5363.678179309254, 5496.80761173357, 390.837802312043, 391.9235749028912, 394.8085178688334, 415.79418187997135, 415.8960259935016, 3676.5771936227143, 3728.906777330534, 3758.624137586274, 3773.7735735855385, 3812.599677033927, 9244.445333280024, 9556.187724043395, 9641.325107242426, 9792.363496372713, 9828.066333698287, 9663.067386522724, 9668.114717629995, 9676.12914837654, 9677.177439917687, 9680.661176858917, 7088.149422069385, 7186.425085993213, 7219.0976127984, 7249.637518124073, 7276.563406195645, 5196.870078248074, 5217.426083130928, 5338.796721966789, 5345.572354211731, 5394.9460505394445, 8883.289336852908, 8922.152395522415, 8970.820583588422, 9035.683751068682, 9054.185123338932, 9016.413933094327, 9044.683436079706, 9144.634214631606, 9196.540172991457, 9255.583498742439, 5735.627184233012, 6304.369563043659, 6511.869762604816, 6598.406143447113, 6602.372774586406, 7451.515651482853, 7629.465937384552, 7679.116901556393, 7702.268284512962, 7705.807354816175, 6807.455403567802, 6829.897551536632, 6929.826754331182, 6956.373926346653, 7175.425965922818, 6686.9331306688255, 6746.69639866217, 6796.082528858541, 6814.965925170342, 6831.316868313129, 6147.692615369124, 6153.784617538365, 6213.37866213375, 6214.285357183981, 6217.285012223652, 4527.637788976808, 4540.772961351985, 4606.378138951199, 4705.7647117644665, 4715.6699031068865, 4511.70673906195, 4603.263477843529, 4711.31685905535, 4765.451973023008, 4774.307725379731], "value": 4016.9139396895625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.5305246343533, 296.74035219183213, 303.6098613281933, 305.4212267752607, 306.63816696298375, 4870.634702397317, 4901.509849015097, 4907.6810007349495, 4910.852674419769, 4911.312416261726, 4807.375041244633, 4808.471068182497, 4826.814302560311, 4875.122477953967, 4883.218685010399, 3626.4922910792575, 3709.647583479565, 3750.587435382106, 3758.098056466442, 3765.152840610868, 3671.963280367202, 3747.0, 3833.195029043904, 3865.6907447404283, 3887.4751908492276, 3780.546334439871, 3786.053486628343, 3804.885853424402, 3806.838914131189, 3828.5214348206473, 3586.910327241814, 3739.046543131511, 3790.0714324990277, 3791.2227993261317, 3823.0824602095295, 3267.803931764102, 3274.607047154333, 3276.0990727549874, 3280.4751239801517, 3280.622728386242, 4744.122337367564, 4754.239321708545, 4777.498362671939, 4783.569478746895, 4785.9521404785855, 4270.316749320125, 4270.444842170498, 4274.551172126944, 4278.657707383401, 4317.201317756225, 4954.7274899880495, 5055.797768089272, 5055.797768089272, 5056.089903817311, 5085.74571271435, 3528.4001719707453, 3548.8288864674855, 3555.1823080691584, 3564.7326450516316, 3577.177249232691, 5372.194170874361, 5375.220593013991, 5402.37872644643, 5425.83722488322, 5427.538659213971, 3474.426719591239, 3659.908502287464, 3667.0465678923674, 3683.894831550524, 3685.74199806011, 3700.6114357992024, 3703.5926048134684, 3712.1833196696684, 3732.6267373263, 3738.513993180869, 4263.445752052214, 4268.466441694788, 4272.786360681954, 4284.828606855691, 4298.570142985676, 4912.361393018885, 5118.923216151761, 5140.306058682105, 5147.124988751922, 5148.330717006766, 1276.7957126859844, 1282.0512820512954, 1288.5618889577402, 1300.6228193823686, 1301.7786976213877, 786.7049856303886, 806.7579726082151, 827.5283088639418, 828.6354004238116, 830.9958450207831, 4382.189294980439, 4396.912061758747, 4497.168023915586, 4543.477500087466, 4557.384753058361, 5270.4188743376835, 5285.520054384701, 5286.286351342596, 5300.3639563252655, 5303.867403314948, 4467.821287148543, 4524.6380289576755, 4535.31970204472, 4545.818167273272, 4548.658850586219, 2662.853543055112, 2779.402428477887, 2790.776737860966, 2802.8738706758245, 2807.694422093736, 4859.829905953275, 4890.119778439844, 4900.656954013256, 4906.8773280668265, 4942.777575009133, 5144.356955380577, 5361.249425080492, 5406.675599464044, 5412.188171774186, 5415.268938693304, 4891.633127515451, 4896.706197628154, 4896.730679812573, 4903.803847846046, 4927.482614325444, 5265.0259701955265, 5272.868178295574, 5284.577233821362, 5290.25936368901, 5292.655977361459, 4949.529794669501, 5117.718525481134, 5126.487351264844, 5157.968406318676, 5160.690358578498, 4864.513548645107, 4869.220924652039, 4875.146849301429, 4875.390576177978, 4879.95120048795, 3686.5391826021746, 3697.35296323137, 3698.3527882619896, 3747.119426934614, 3749.3626083566405, 5013.573846223112, 5310.628256022042, 5312.203169524448, 5323.920141197807, 5333.573314134937, 5169.017886601534, 5170.1727723564045, 5171.534561889448, 5174.120399532164, 5186.974065129651, 5142.460041695717, 5153.917677287662, 5169.922451163311, 5189.714565698923, 5192.9740351298005, 4849.854504364875, 5026.346574945233, 5145.845624631267, 5154.845354639367, 5154.845354639367, 4913.06651736169, 4981.576565991786, 5108.897822043613, 5143.8456846294675, 5151.356080489939, 5040.14317566022, 5040.546350828443, 5046.394432668103, 5047.848564543069, 5106.897862042664], "value": 3828.651461132895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.1825396825396, 614.7878981751294, 657.4280376072817, 663.8008597420773, 729.1032030602357, 11657.533698652054, 11961.342126183079, 11976.880231197685, 11981.101417393698, 11995.700107497318, 12647.114701970866, 12778.0, 12822.166559173671, 12822.422990965406, 12859.099863009593, 633.0662273147117, 759.6012093650822, 769.3614300130891, 787.3307688464788, 788.0936922539069, 767.2595944913157, 767.5394763142126, 769.3153093746542, 770.2913319745819, 771.8070482379405, 833.0170398929291, 833.1002517281352, 835.0855812884912, 835.1606635331514, 835.9205875441854, 664.110092476082, 793.4842352470882, 818.4516374029355, 821.6631181215703, 823.5758584329076, 605.5337390209514, 607.8662694207268, 608.2974164839617, 608.3308360803126, 608.4068033667183, 11789.0, 11833.763324733458, 11844.466998985066, 11866.288022718665, 11867.347295898722, 12455.75088498234, 12709.110362274645, 12719.618411447671, 12978.221306721627, 13231.933840330737, 9828.312018158731, 11547.422628868608, 11604.535818567247, 11758.17692761507, 12239.755204895851, 4081.306177949726, 4132.690048246393, 4150.709450338478, 4195.160967806421, 4253.659707223445, 60680.69659651718, 62237.0, 62449.0, 63403.36596634021, 64100.35899640991, 10126.088652021206, 10154.325442049654, 10322.535485903152, 10346.689599312032, 10402.687919362432, 18014.0, 18033.639327213645, 18040.0, 18058.729119063224, 18060.90969545144, 6527.5430719849155, 6602.636854972927, 6614.239362473281, 6762.932370676329, 6772.93227067723, 3471.739619528495, 3548.8580456781438, 3678.9816050919576, 3746.119661879456, 3759.49246851677, 2803.719628037221, 2858.957115643267, 2866.7706583473273, 2876.194665493665, 2879.7120287971034, 497.75609951124414, 502.703404991057, 511.64696359511817, 517.8679436743606, 524.2764984321688, 405.37774516117616, 533.3201159822588, 542.6798189068469, 570.8715539003691, 572.928383952006, 7291.416686665054, 7419.332260096618, 7452.925470745223, 7696.268854458817, 7762.184970578008, 376.9302679004393, 404.8866317431124, 461.0226320201195, 519.3015394294667, 519.7764961066702, 3786.2238241160494, 3841.654251117413, 4113.0, 4233.97883010583, 4310.504292006397, 92233.0, 104206.47896760468, 105523.0, 108825.45587272014, 108981.45509272403, 80461.59769201117, 83089.0, 84448.57775711206, 87124.38626841205, 99016.5049174764, 43449.34825977613, 45245.77377113093, 70678.0, 70985.25640064185, 72979.0, 8098.271155596025, 8110.918890811016, 8266.917330826614, 8355.665773369241, 8729.956350218208, 42200.1559968805, 43556.0, 44980.32529511995, 45081.0, 45759.77120114378, 62542.0, 65288.67355663381, 65862.0, 65934.67032664806, 67222.0, 11108.44457777124, 11283.943580282046, 11534.077273818242, 11673.182877198855, 11846.11154163424, 12570.0, 12654.177478463871, 13432.462701491831, 13559.0, 13685.863141368856, 11551.826722599335, 11719.707007324885, 12026.879731202926, 12099.57651482194, 12785.552505662628, 12096.576619818265, 12760.361981901053, 12791.872081279069, 12865.935670321589, 13084.58551409754, 11743.236689615489, 11903.285802851857, 12183.208091474025, 12508.687282817638, 12560.246385216917, 8835.160659737314, 8896.555172241233, 8915.643374265217, 9205.815883682422, 9482.57328420209, 9406.95296523513, 10054.396736195851, 10439.53022114022, 10563.260571760211, 10579.682609521727], "value": 6487.214162095066, "unit": "score"}], "name": "dromaeo_css", "value": 6381.6995686738055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 113.0, 113.0, 114.0, 116.0, 113.0, 113.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 123.0, 182.0, 122.0, 127.0, 147.0, 122.0, 167.0, 122.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 160.0, 161.0, 160.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 119.0, 87.0, 78.0, 75.0, 76.0, 101.0, 77.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 115.0, 86.0, 85.0, 86.0, 112.0, 85.0, 85.0, 120.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 67.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 81.0, 79.0, 80.0, 80.0, 81.0, 80.0, 93.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 130.0, 131.0, 136.0, 138.0, 134.0, 130.0, 168.0, 130.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 168.0, 166.0, 168.0, 170.0, 161.0, 160.0, 165.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 67.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1525.4000000000003, "alertThreshold": 2.0}]} 01:25:32 INFO - Return code: 0 01:25:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:25:32 INFO - # TBPL SUCCESS # 01:25:32 INFO - Running post-action listener: _resource_record_post_action 01:25:32 INFO - [mozharness: 2016-07-25 08:25:32.854539Z] Finished run-tests step (success) 01:25:32 INFO - Running post-run listener: _resource_record_post_run 01:25:32 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 546672640; Read time: 260; Write time: 421552 01:25:32 INFO - TinderboxPrint: CPU usage
13.0% 01:25:32 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 260 01:25:32 INFO - TinderboxPrint: I/O write bytes / time
546,672,640 / 421,552 01:25:32 INFO - TinderboxPrint: CPU idle
8,328.1 (87.0%) 01:25:32 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 01:25:32 INFO - TinderboxPrint: Swap in / out
0 / 0 01:25:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 254107648; Read time: 84; Write time: 235020 01:25:32 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288034816; Read time: 168; Write time: 186116 01:25:33 INFO - Running post-run listener: _upload_blobber_files 01:25:33 INFO - Blob upload gear active. 01:25:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:25:33 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 01:25:33 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'] 01:25:33 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 01:25:33 INFO - (blobuploader) - INFO - Open directory for files ... 01:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:25:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:41 INFO - (blobuploader) - INFO - Done attempting. 01:25:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:25:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:42 INFO - (blobuploader) - INFO - Done attempting. 01:25:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:25:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:25:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:43 INFO - (blobuploader) - INFO - Done attempting. 01:25:43 INFO - (blobuploader) - INFO - Iteration through files over. 01:25:43 INFO - Return code: 0 01:25:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:25:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:25:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aa65c88780eb3b02e3708ed4b3df3ace5663916ebf8c9a087cf1350fb48a171bc78ab0fea5634ff547428d26dfd2dd6b2e3f9b42cb3b8aec8c94fa2f77305f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9d176075a7b58bc3596185045682e09960cb8ab8cadf0e2ed8a5e1bcf7421c2b870d632b2197a80e3d12104a6628c3d8021421ead1c3e6edeb90d2e4852339a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bd3af5f4d1aa2e840275b582f632035547eafa7f7f4e1f1dafabb49a8b3fa35c8fc924c475ceb4668591d4c05e0c8726a3a529bf43f049c76d7228570eac92c"} 01:25:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:25:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:25:43 INFO - Contents: 01:25:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aa65c88780eb3b02e3708ed4b3df3ace5663916ebf8c9a087cf1350fb48a171bc78ab0fea5634ff547428d26dfd2dd6b2e3f9b42cb3b8aec8c94fa2f77305f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9d176075a7b58bc3596185045682e09960cb8ab8cadf0e2ed8a5e1bcf7421c2b870d632b2197a80e3d12104a6628c3d8021421ead1c3e6edeb90d2e4852339a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bd3af5f4d1aa2e840275b582f632035547eafa7f7f4e1f1dafabb49a8b3fa35c8fc924c475ceb4668591d4c05e0c8726a3a529bf43f049c76d7228570eac92c"} 01:25:43 INFO - Running post-run listener: copy_logs_to_upload_dir 01:25:43 INFO - Copying logs to upload dir... 01:25:43 INFO - mkdir: /builds/slave/test/build/upload/logs 01:25:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.527138 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-25 01:25:41.600137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 01:25:41.603877) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aa65c88780eb3b02e3708ed4b3df3ace5663916ebf8c9a087cf1350fb48a171bc78ab0fea5634ff547428d26dfd2dd6b2e3f9b42cb3b8aec8c94fa2f77305f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9d176075a7b58bc3596185045682e09960cb8ab8cadf0e2ed8a5e1bcf7421c2b870d632b2197a80e3d12104a6628c3d8021421ead1c3e6edeb90d2e4852339a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bd3af5f4d1aa2e840275b582f632035547eafa7f7f4e1f1dafabb49a8b3fa35c8fc924c475ceb4668591d4c05e0c8726a3a529bf43f049c76d7228570eac92c"} build_url:https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/SuP3bSwHSKuJJ9N7pHpEgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aa65c88780eb3b02e3708ed4b3df3ace5663916ebf8c9a087cf1350fb48a171bc78ab0fea5634ff547428d26dfd2dd6b2e3f9b42cb3b8aec8c94fa2f77305f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9d176075a7b58bc3596185045682e09960cb8ab8cadf0e2ed8a5e1bcf7421c2b870d632b2197a80e3d12104a6628c3d8021421ead1c3e6edeb90d2e4852339a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bd3af5f4d1aa2e840275b582f632035547eafa7f7f4e1f1dafabb49a8b3fa35c8fc924c475ceb4668591d4c05e0c8726a3a529bf43f049c76d7228570eac92c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 01:25:41.629788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:25:41.630197) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469432711.443220-1835457380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 01:25:41.714296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 01:25:41.714654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 01:25:41.714979) ========= ========= Total master_lag: 0.18 =========