builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1469927516.74 results: success (0) buildid: 20160730165725 builduid: f9888317027141e9babd958e42401f62 revision: c761bfb5fd83eb0d767adbf34012b7dda384dce9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.744159) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.744634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.744964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.765635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.765981) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 18:11:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-30 18:11:57 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105821 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.913297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.913659) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015718 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.981316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:56.981687) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c761bfb5fd83eb0d767adbf34012b7dda384dce9 --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 c761bfb5fd83eb0d767adbf34012b7dda384dce9 --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=31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 18:11:57,350 truncating revision to first 12 chars 2016-07-30 18:11:57,350 Setting DEBUG logging. 2016-07-30 18:11:57,350 attempt 1/10 2016-07-30 18:11:57,350 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c761bfb5fd83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 18:11:57,708 unpacking tar archive at: autoland-c761bfb5fd83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732104 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:57.761956) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:57.762235) ========= script_repo_revision: c761bfb5fd83eb0d767adbf34012b7dda384dce9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:57.762633) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:57.762904) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 18:11:57.774395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-30 18:11:57.774746) ========= /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=31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:11:58 INFO - MultiFileLogger online at 20160730 18:11:58 in /builds/slave/test 18:11:58 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 18:11:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:58 INFO - {'append_to_log': False, 18:11:58 INFO - 'base_work_dir': '/builds/slave/test', 18:11:58 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 18:11:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:58 INFO - 'branch': 'Autoland-Non-PGO', 18:11:58 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:58 INFO - 'config_files': ('talos/linux_config.py',), 18:11:58 INFO - 'default_actions': ('clobber', 18:11:58 INFO - 'read-buildbot-config', 18:11:58 INFO - 'download-and-extract', 18:11:58 INFO - 'populate-webroot', 18:11:58 INFO - 'create-virtualenv', 18:11:58 INFO - 'install', 18:11:58 INFO - 'run-tests'), 18:11:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:58 INFO - 'download_minidump_stackwalk': True, 18:11:58 INFO - 'download_symbols': 'ondemand', 18:11:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:58 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:58 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:58 INFO - 'installer_path': 'installer.exe', 18:11:58 INFO - 'log_level': 'info', 18:11:58 INFO - 'log_name': 'talos', 18:11:58 INFO - 'log_to_console': True, 18:11:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:11:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:11:58 INFO - 'opt_config_files': (), 18:11:58 INFO - 'pip_index': False, 18:11:58 INFO - 'sps_profile': False, 18:11:58 INFO - 'sps_profile_interval': 0, 18:11:58 INFO - 'suite': 'dromaeojs', 18:11:58 INFO - 'system_bits': '32', 18:11:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:58 INFO - 'title': 'talos-linux64-ix-014', 18:11:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:58 INFO - 'use_talos_json': True, 18:11:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:58 INFO - 'work_dir': 'build'} 18:11:58 INFO - [mozharness: 2016-07-31 01:11:58.216474Z] Running clobber step. 18:11:58 INFO - Running pre-action listener: _resource_record_pre_action 18:11:58 INFO - Running main action method: clobber 18:11:58 INFO - rmtree: /builds/slave/test/build 18:11:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:58 INFO - Running post-action listener: _resource_record_post_action 18:11:58 INFO - [mozharness: 2016-07-31 01:11:58.677454Z] Finished clobber step (success) 18:11:58 INFO - [mozharness: 2016-07-31 01:11:58.677556Z] Running read-buildbot-config step. 18:11:58 INFO - Running pre-action listener: _resource_record_pre_action 18:11:58 INFO - Running main action method: read_buildbot_config 18:11:58 INFO - Using buildbot properties: 18:11:58 INFO - { 18:11:58 INFO - "project": "", 18:11:58 INFO - "product": "firefox", 18:11:58 INFO - "script_repo_revision": "production", 18:11:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 18:11:58 INFO - "repository": "", 18:11:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 18:11:58 INFO - "buildid": "20160730165725", 18:11:58 INFO - "pgo_build": "False", 18:11:58 INFO - "basedir": "/builds/slave/test", 18:11:58 INFO - "buildnumber": 188, 18:11:58 INFO - "slavename": "talos-linux64-ix-014", 18:11:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:11:58 INFO - "platform": "ubuntu64_hw", 18:11:58 INFO - "scheduler": "tests-autoland-linux64-talos", 18:11:58 INFO - "branch": "autoland", 18:11:58 INFO - "repo_path": "integration/autoland", 18:11:58 INFO - "revision": "c761bfb5fd83eb0d767adbf34012b7dda384dce9", 18:11:58 INFO - "stage_platform": "linux64", 18:11:58 INFO - "builduid": "f9888317027141e9babd958e42401f62", 18:11:58 INFO - "slavebuilddir": "test" 18:11:58 INFO - } 18:11:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:11:58 INFO - Running post-action listener: _resource_record_post_action 18:11:58 INFO - [mozharness: 2016-07-31 01:11:58.680013Z] Finished read-buildbot-config step (success) 18:11:58 INFO - [mozharness: 2016-07-31 01:11:58.680100Z] Running download-and-extract step. 18:11:58 INFO - Running pre-action listener: _resource_record_pre_action 18:11:58 INFO - Running main action method: download_and_extract 18:11:58 INFO - mkdir: /builds/slave/test/build/tests 18:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:58 INFO - https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:11:59 INFO - Downloaded 1361 bytes. 18:11:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:11:59 INFO - Using the following test package requirements: 18:11:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:11:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:11:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:11:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'jsshell-linux-x86_64.zip'], 18:11:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:11:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:11:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:11:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:11:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:11:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:11:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:11:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:59 INFO - https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:11:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:11:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:11:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:12:00 INFO - Downloaded 20234639 bytes. 18:12:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:12:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:12:02 INFO - Return code: 0 18:12:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:02 INFO - https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:12:12 INFO - Downloaded 20234639 bytes. 18:12:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:12:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:12:13 INFO - Return code: 0 18:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:13 INFO - https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:12:14 INFO - Downloaded 14413723 bytes. 18:12:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:12:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:12:15 INFO - Return code: 0 18:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:15 INFO - https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:12:16 INFO - Downloaded 55661644 bytes. 18:12:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:12:16 INFO - mkdir: /builds/slave/test/properties 18:12:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:12:16 INFO - Writing to file /builds/slave/test/properties/build_url 18:12:16 INFO - Contents: 18:12:16 INFO - build_url:https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:12:16 INFO - Running post-action listener: _resource_record_post_action 18:12:16 INFO - Running post-action listener: set_extra_try_arguments 18:12:16 INFO - [mozharness: 2016-07-31 01:12:16.976338Z] Finished download-and-extract step (success) 18:12:16 INFO - [mozharness: 2016-07-31 01:12:16.976571Z] Running populate-webroot step. 18:12:16 INFO - Running pre-action listener: _resource_record_pre_action 18:12:16 INFO - Running main action method: populate_webroot 18:12:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:12:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:12:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:12:16 INFO - '--tppagecycles', 18:12:16 INFO - '7'], 18:12:16 INFO - 'tests': ['tsvgm']}}, 18:12:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:12:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:12:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:12:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:12:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['damp', 'tps']}, 18:12:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'tests': ['damp', 'tps']}, 18:12:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['dromaeo_dom']}, 18:12:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:12:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['basic_compositor_video']}, 18:12:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:12:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['a11yr', 18:12:16 INFO - 'ts_paint', 18:12:16 INFO - 'tpaint', 18:12:16 INFO - 'sessionrestore', 18:12:16 INFO - 'sessionrestore_no_auto_restore', 18:12:16 INFO - 'tabpaint']}, 18:12:16 INFO - 'other-e10s': {'tests': ['a11yr', 18:12:16 INFO - 'ts_paint', 18:12:16 INFO - 'tpaint', 18:12:16 INFO - 'sessionrestore', 18:12:16 INFO - 'sessionrestore_no_auto_restore', 18:12:16 INFO - 'tabpaint']}, 18:12:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:12:16 INFO - 'ts_paint', 18:12:16 INFO - 'tpaint', 18:12:16 INFO - 'sessionrestore', 18:12:16 INFO - 'sessionrestore_no_auto_restore', 18:12:16 INFO - 'tabpaint']}, 18:12:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:12:16 INFO - 'ts_paint', 18:12:16 INFO - 'tpaint', 18:12:16 INFO - 'sessionrestore', 18:12:16 INFO - 'sessionrestore_no_auto_restore', 18:12:16 INFO - 'tabpaint']}, 18:12:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['a11yr', 18:12:16 INFO - 'ts_paint', 18:12:16 INFO - 'tpaint', 18:12:16 INFO - 'sessionrestore', 18:12:16 INFO - 'sessionrestore_no_auto_restore', 18:12:16 INFO - 'tabpaint']}, 18:12:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['a11yr', 18:12:16 INFO - 'ts_paint', 18:12:16 INFO - 'tpaint', 18:12:16 INFO - 'sessionrestore', 18:12:16 INFO - 'sessionrestore_no_auto_restore', 18:12:16 INFO - 'tabpaint']}, 18:12:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['tsvgx', 18:12:16 INFO - 'tsvgr_opacity', 18:12:16 INFO - 'tart', 18:12:16 INFO - 'tscrollx', 18:12:16 INFO - 'cart']}, 18:12:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:12:16 INFO - 'tsvgr_opacity', 18:12:16 INFO - 'tart', 18:12:16 INFO - 'tscrollx', 18:12:16 INFO - 'cart']}, 18:12:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'talos_options': ['--disable-e10s'], 18:12:16 INFO - 'tests': ['tp5o']}, 18:12:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'tests': ['tp5o']}, 18:12:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'talos_options': ['--disable-e10s', 18:12:16 INFO - '--xperf_path', 18:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:16 INFO - 'tests': ['tp5n']}, 18:12:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:16 INFO - 'talos_options': ['--xperf_path', 18:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:16 INFO - 'tests': ['tp5n']}}, 18:12:16 INFO - 'talos.zip': {'path': '', 18:12:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:12:16 INFO - Running post-action listener: _resource_record_post_action 18:12:16 INFO - [mozharness: 2016-07-31 01:12:16.994185Z] Finished populate-webroot step (success) 18:12:16 INFO - [mozharness: 2016-07-31 01:12:16.994275Z] Running create-virtualenv step. 18:12:16 INFO - Running pre-action listener: _resource_record_pre_action 18:12:16 INFO - Running main action method: create_virtualenv 18:12:16 INFO - Creating virtualenv /builds/slave/test/build/venv 18:12:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:12:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:12:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:12:17 INFO - Using real prefix '/usr' 18:12:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:12:17 INFO - Installing distribute.............................................................................................................................................................................................done. 18:12:19 INFO - Installing pip.................done. 18:12:19 INFO - Return code: 0 18:12:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12: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', 'pip>=1.5'] in /builds/slave/test/build 18:12: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 pip>=1.5 18:12:19 INFO - Using env: {'DISPLAY': ':0', 18:12:19 INFO - 'HOME': '/home/cltbld', 18:12:19 INFO - 'LANG': 'en_US.UTF-8', 18:12:19 INFO - 'LANGUAGE': 'en_US:en', 18:12:19 INFO - 'LOGNAME': 'cltbld', 18:12:19 INFO - 'MAIL': '/var/mail/cltbld', 18:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:19 INFO - 'MOZ_NO_REMOTE': '1', 18:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:19 INFO - 'NO_EM_RESTART': '1', 18:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:19 INFO - 'PWD': '/builds/slave/test', 18:12:19 INFO - 'SHELL': '/bin/bash', 18:12:19 INFO - 'SHLVL': '1', 18:12:19 INFO - 'TERM': 'linux', 18:12:19 INFO - 'TMOUT': '86400', 18:12:19 INFO - 'USER': 'cltbld', 18:12:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:19 INFO - '_': '/tools/buildbot/bin/python'} 18:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:12:19 INFO - Cleaning up... 18:12:19 INFO - Return code: 0 18:12:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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', '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 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:12: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 psutil>=3.1.1 18:12:19 INFO - Using env: {'DISPLAY': ':0', 18:12:19 INFO - 'HOME': '/home/cltbld', 18:12:19 INFO - 'LANG': 'en_US.UTF-8', 18:12:19 INFO - 'LANGUAGE': 'en_US:en', 18:12:19 INFO - 'LOGNAME': 'cltbld', 18:12:19 INFO - 'MAIL': '/var/mail/cltbld', 18:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:19 INFO - 'MOZ_NO_REMOTE': '1', 18:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:19 INFO - 'NO_EM_RESTART': '1', 18:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:19 INFO - 'PWD': '/builds/slave/test', 18:12:19 INFO - 'SHELL': '/bin/bash', 18:12:19 INFO - 'SHLVL': '1', 18:12:19 INFO - 'TERM': 'linux', 18:12:19 INFO - 'TMOUT': '86400', 18:12:19 INFO - 'USER': 'cltbld', 18:12:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:19 INFO - '_': '/tools/buildbot/bin/python'} 18:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:20 INFO - Downloading/unpacking psutil>=3.1.1 18:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:22 INFO - Installing collected packages: psutil 18:12:22 INFO - Running setup.py install for psutil 18:12:22 INFO - building 'psutil._psutil_linux' extension 18:12:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:12:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:12:22 INFO - building 'psutil._psutil_posix' extension 18:12:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:12:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:12:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:22 INFO - Successfully installed psutil 18:12:22 INFO - Cleaning up... 18:12:22 INFO - Return code: 0 18:12:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:12: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 mozsystemmonitor==0.3 18:12:22 INFO - Using env: {'DISPLAY': ':0', 18:12:22 INFO - 'HOME': '/home/cltbld', 18:12:22 INFO - 'LANG': 'en_US.UTF-8', 18:12:22 INFO - 'LANGUAGE': 'en_US:en', 18:12:22 INFO - 'LOGNAME': 'cltbld', 18:12:22 INFO - 'MAIL': '/var/mail/cltbld', 18:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:22 INFO - 'MOZ_NO_REMOTE': '1', 18:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:22 INFO - 'NO_EM_RESTART': '1', 18:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:22 INFO - 'PWD': '/builds/slave/test', 18:12:22 INFO - 'SHELL': '/bin/bash', 18:12:22 INFO - 'SHLVL': '1', 18:12:22 INFO - 'TERM': 'linux', 18:12:22 INFO - 'TMOUT': '86400', 18:12:22 INFO - 'USER': 'cltbld', 18:12:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:22 INFO - '_': '/tools/buildbot/bin/python'} 18:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:12:24 INFO - Installing collected packages: mozsystemmonitor 18:12:24 INFO - Running setup.py install for mozsystemmonitor 18:12:24 INFO - Successfully installed mozsystemmonitor 18:12:24 INFO - Cleaning up... 18:12:24 INFO - Return code: 0 18:12:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:24 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 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:12:24 INFO - Using env: {'DISPLAY': ':0', 18:12:24 INFO - 'HOME': '/home/cltbld', 18:12:24 INFO - 'LANG': 'en_US.UTF-8', 18:12:24 INFO - 'LANGUAGE': 'en_US:en', 18:12:24 INFO - 'LOGNAME': 'cltbld', 18:12:24 INFO - 'MAIL': '/var/mail/cltbld', 18:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:24 INFO - 'MOZ_NO_REMOTE': '1', 18:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:24 INFO - 'NO_EM_RESTART': '1', 18:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:24 INFO - 'PWD': '/builds/slave/test', 18:12:24 INFO - 'SHELL': '/bin/bash', 18:12:24 INFO - 'SHLVL': '1', 18:12:24 INFO - 'TERM': 'linux', 18:12:24 INFO - 'TMOUT': '86400', 18:12:24 INFO - 'USER': 'cltbld', 18:12:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:24 INFO - '_': '/tools/buildbot/bin/python'} 18:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:25 INFO - Downloading/unpacking jsonschema==2.5.1 18:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:26 INFO - warning: no files found matching '*.txt' 18:12:26 INFO - no previously-included directories found matching 'build' 18:12:26 INFO - no previously-included directories found matching 'dist' 18:12:26 INFO - no previously-included directories found matching '.git*' 18:12:26 INFO - Installing collected packages: jsonschema, functools32 18:12:26 INFO - Running setup.py install for functools32 18:12:26 INFO - warning: no files found matching '*.txt' 18:12:26 INFO - no previously-included directories found matching 'build' 18:12:26 INFO - no previously-included directories found matching 'dist' 18:12:26 INFO - no previously-included directories found matching '.git*' 18:12:26 INFO - Successfully installed jsonschema functools32 18:12:26 INFO - Cleaning up... 18:12:26 INFO - Return code: 0 18:12:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:26 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 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:12:26 INFO - Using env: {'DISPLAY': ':0', 18:12:26 INFO - 'HOME': '/home/cltbld', 18:12:26 INFO - 'LANG': 'en_US.UTF-8', 18:12:26 INFO - 'LANGUAGE': 'en_US:en', 18:12:26 INFO - 'LOGNAME': 'cltbld', 18:12:26 INFO - 'MAIL': '/var/mail/cltbld', 18:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:26 INFO - 'MOZ_NO_REMOTE': '1', 18:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:26 INFO - 'NO_EM_RESTART': '1', 18:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:26 INFO - 'PWD': '/builds/slave/test', 18:12:26 INFO - 'SHELL': '/bin/bash', 18:12:26 INFO - 'SHLVL': '1', 18:12:26 INFO - 'TERM': 'linux', 18:12:26 INFO - 'TMOUT': '86400', 18:12:26 INFO - 'USER': 'cltbld', 18:12:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:26 INFO - '_': '/tools/buildbot/bin/python'} 18:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:12:26 INFO - Cleaning up... 18:12:26 INFO - Return code: 0 18:12:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:26 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 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:12:26 INFO - Using env: {'DISPLAY': ':0', 18:12:26 INFO - 'HOME': '/home/cltbld', 18:12:26 INFO - 'LANG': 'en_US.UTF-8', 18:12:26 INFO - 'LANGUAGE': 'en_US:en', 18:12:26 INFO - 'LOGNAME': 'cltbld', 18:12:26 INFO - 'MAIL': '/var/mail/cltbld', 18:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:26 INFO - 'MOZ_NO_REMOTE': '1', 18:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:26 INFO - 'NO_EM_RESTART': '1', 18:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:26 INFO - 'PWD': '/builds/slave/test', 18:12:26 INFO - 'SHELL': '/bin/bash', 18:12:26 INFO - 'SHLVL': '1', 18:12:26 INFO - 'TERM': 'linux', 18:12:26 INFO - 'TMOUT': '86400', 18:12:26 INFO - 'USER': 'cltbld', 18:12:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:26 INFO - '_': '/tools/buildbot/bin/python'} 18:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:26 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:28 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:29 INFO - Downloading docopt-0.6.1.tar.gz 18:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:29 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:29 INFO - Running setup.py install for blobuploader 18:12:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:29 INFO - Running setup.py install for requests 18:12:30 INFO - Running setup.py install for docopt 18:12:30 INFO - Successfully installed blobuploader requests docopt 18:12:30 INFO - Cleaning up... 18:12:30 INFO - Return code: 0 18:12:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:30 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 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:30 INFO - Using env: {'DISPLAY': ':0', 18:12:30 INFO - 'HOME': '/home/cltbld', 18:12:30 INFO - 'LANG': 'en_US.UTF-8', 18:12:30 INFO - 'LANGUAGE': 'en_US:en', 18:12:30 INFO - 'LOGNAME': 'cltbld', 18:12:30 INFO - 'MAIL': '/var/mail/cltbld', 18:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:30 INFO - 'MOZ_NO_REMOTE': '1', 18:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:30 INFO - 'NO_EM_RESTART': '1', 18:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:30 INFO - 'PWD': '/builds/slave/test', 18:12:30 INFO - 'SHELL': '/bin/bash', 18:12:30 INFO - 'SHLVL': '1', 18:12:30 INFO - 'TERM': 'linux', 18:12:30 INFO - 'TMOUT': '86400', 18:12:30 INFO - 'USER': 'cltbld', 18:12:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:30 INFO - '_': '/tools/buildbot/bin/python'} 18:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:30 INFO - Running setup.py (path:/tmp/pip-iEJxHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:30 INFO - Running setup.py (path:/tmp/pip-NI_04F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:30 INFO - Running setup.py (path:/tmp/pip-sQ_DpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:30 INFO - Running setup.py (path:/tmp/pip-5xtw2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:30 INFO - Running setup.py (path:/tmp/pip-feCQku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:30 INFO - Running setup.py (path:/tmp/pip-zdlnon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:30 INFO - Running setup.py (path:/tmp/pip-PJT0EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:30 INFO - Running setup.py (path:/tmp/pip-X1If4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:30 INFO - Running setup.py (path:/tmp/pip-8pKh7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:31 INFO - Running setup.py (path:/tmp/pip-xf89BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:31 INFO - Running setup.py (path:/tmp/pip-tIuLnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:31 INFO - Running setup.py (path:/tmp/pip-K28ZG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:31 INFO - Running setup.py (path:/tmp/pip-Fkh_3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:31 INFO - Running setup.py (path:/tmp/pip-TdnKCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:31 INFO - Running setup.py (path:/tmp/pip-hLgEz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:31 INFO - Running setup.py (path:/tmp/pip-So41gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:31 INFO - Running setup.py (path:/tmp/pip-gr1EgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:31 INFO - Running setup.py install for manifestparser 18:12:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Running setup.py install for mozcrash 18:12:31 INFO - Running setup.py install for mozdebug 18:12:31 INFO - Running setup.py install for mozdevice 18:12:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Running setup.py install for mozfile 18:12:32 INFO - Running setup.py install for mozhttpd 18:12:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Running setup.py install for mozinfo 18:12:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Running setup.py install for mozInstall 18:12:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Running setup.py install for mozleak 18:12:32 INFO - Running setup.py install for mozlog 18:12:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Running setup.py install for moznetwork 18:12:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Running setup.py install for mozprocess 18:12:32 INFO - Running setup.py install for mozprofile 18:12:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Running setup.py install for mozrunner 18:12:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:33 INFO - Running setup.py install for mozscreenshot 18:12:33 INFO - Running setup.py install for moztest 18:12:33 INFO - Running setup.py install for mozversion 18:12:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:33 INFO - Cleaning up... 18:12:33 INFO - Return code: 0 18:12:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:33 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 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:33 INFO - Using env: {'DISPLAY': ':0', 18:12:33 INFO - 'HOME': '/home/cltbld', 18:12:33 INFO - 'LANG': 'en_US.UTF-8', 18:12:33 INFO - 'LANGUAGE': 'en_US:en', 18:12:33 INFO - 'LOGNAME': 'cltbld', 18:12:33 INFO - 'MAIL': '/var/mail/cltbld', 18:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:33 INFO - 'MOZ_NO_REMOTE': '1', 18:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:33 INFO - 'NO_EM_RESTART': '1', 18:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:33 INFO - 'PWD': '/builds/slave/test', 18:12:33 INFO - 'SHELL': '/bin/bash', 18:12:33 INFO - 'SHLVL': '1', 18:12:33 INFO - 'TERM': 'linux', 18:12:33 INFO - 'TMOUT': '86400', 18:12:33 INFO - 'USER': 'cltbld', 18:12:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:33 INFO - '_': '/tools/buildbot/bin/python'} 18:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:33 INFO - Running setup.py (path:/tmp/pip-CXyOjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:33 INFO - Running setup.py (path:/tmp/pip-CVnxms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:33 INFO - Running setup.py (path:/tmp/pip-8xTLGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:33 INFO - Running setup.py (path:/tmp/pip-hNxEXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:33 INFO - Running setup.py (path:/tmp/pip-HfaDTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:33 INFO - Running setup.py (path:/tmp/pip-92CH7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:34 INFO - Running setup.py (path:/tmp/pip-WZHLbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:34 INFO - Running setup.py (path:/tmp/pip-XBq7ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:34 INFO - Running setup.py (path:/tmp/pip-htUKso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:34 INFO - Running setup.py (path:/tmp/pip-1oqd4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:34 INFO - Running setup.py (path:/tmp/pip-CiWom3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:34 INFO - Running setup.py (path:/tmp/pip-Sn6HAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:34 INFO - Running setup.py (path:/tmp/pip-L5K78Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:34 INFO - Running setup.py (path:/tmp/pip-oaNeLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:34 INFO - Running setup.py (path:/tmp/pip-S6N_wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:34 INFO - Running setup.py (path:/tmp/pip-pfX3A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:34 INFO - Running setup.py (path:/tmp/pip-VLnELE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:36 INFO - Downloading blessings-1.6.tar.gz 18:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:36 INFO - Installing collected packages: blessings 18:12:36 INFO - Running setup.py install for blessings 18:12:36 INFO - Successfully installed blessings 18:12:36 INFO - Cleaning up... 18:12:36 INFO - Return code: 0 18:12:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:37 INFO - Reading from file tmpfile_stdout 18:12:37 INFO - Current package versions: 18:12:37 INFO - argparse == 1.2.1 18:12:37 INFO - blessings == 1.6 18:12:37 INFO - blobuploader == 1.2.4 18:12:37 INFO - docopt == 0.6.1 18:12:37 INFO - functools32 == 3.2.3-2 18:12:37 INFO - jsonschema == 2.5.1 18:12:37 INFO - manifestparser == 1.1 18:12:37 INFO - mozInstall == 1.12 18:12:37 INFO - mozcrash == 0.17 18:12:37 INFO - mozdebug == 0.1 18:12:37 INFO - mozdevice == 0.48 18:12:37 INFO - mozfile == 1.2 18:12:37 INFO - mozhttpd == 0.7 18:12:37 INFO - mozinfo == 0.9 18:12:37 INFO - mozleak == 0.1 18:12:37 INFO - mozlog == 3.3 18:12:37 INFO - moznetwork == 0.27 18:12:37 INFO - mozprocess == 0.23 18:12:37 INFO - mozprofile == 0.28 18:12:37 INFO - mozrunner == 6.12 18:12:37 INFO - mozscreenshot == 0.1 18:12:37 INFO - mozsystemmonitor == 0.3 18:12:37 INFO - moztest == 0.7 18:12:37 INFO - mozversion == 1.4 18:12:37 INFO - psutil == 3.1.1 18:12:37 INFO - requests == 1.2.3 18:12:37 INFO - wsgiref == 0.1.2 18:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:37 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 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:37 INFO - Using env: {'DISPLAY': ':0', 18:12:37 INFO - 'HOME': '/home/cltbld', 18:12:37 INFO - 'LANG': 'en_US.UTF-8', 18:12:37 INFO - 'LANGUAGE': 'en_US:en', 18:12:37 INFO - 'LOGNAME': 'cltbld', 18:12:37 INFO - 'MAIL': '/var/mail/cltbld', 18:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:37 INFO - 'MOZ_NO_REMOTE': '1', 18:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:37 INFO - 'NO_EM_RESTART': '1', 18:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:37 INFO - 'PWD': '/builds/slave/test', 18:12:37 INFO - 'SHELL': '/bin/bash', 18:12:37 INFO - 'SHLVL': '1', 18:12:37 INFO - 'TERM': 'linux', 18:12:37 INFO - 'TMOUT': '86400', 18:12:37 INFO - 'USER': 'cltbld', 18:12:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:37 INFO - '_': '/tools/buildbot/bin/python'} 18:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:12:37 INFO - Cleaning up... 18:12:37 INFO - Return code: 0 18:12:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:12:37 INFO - Using env: {'DISPLAY': ':0', 18:12:37 INFO - 'HOME': '/home/cltbld', 18:12:37 INFO - 'LANG': 'en_US.UTF-8', 18:12:37 INFO - 'LANGUAGE': 'en_US:en', 18:12:37 INFO - 'LOGNAME': 'cltbld', 18:12:37 INFO - 'MAIL': '/var/mail/cltbld', 18:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:37 INFO - 'MOZ_NO_REMOTE': '1', 18:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:37 INFO - 'NO_EM_RESTART': '1', 18:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:37 INFO - 'PWD': '/builds/slave/test', 18:12:37 INFO - 'SHELL': '/bin/bash', 18:12:37 INFO - 'SHLVL': '1', 18:12:37 INFO - 'TERM': 'linux', 18:12:37 INFO - 'TMOUT': '86400', 18:12:37 INFO - 'USER': 'cltbld', 18:12:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:37 INFO - '_': '/tools/buildbot/bin/python'} 18:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:37 INFO - Cleaning up... 18:12:37 INFO - Return code: 0 18:12:37 INFO - Running post-action listener: _resource_record_post_action 18:12:37 INFO - Running post-action listener: _start_resource_monitoring 18:12:37 INFO - Starting resource monitoring. 18:12:37 INFO - [mozharness: 2016-07-31 01:12:37.639865Z] Finished create-virtualenv step (success) 18:12:37 INFO - [mozharness: 2016-07-31 01:12:37.640347Z] Running install step. 18:12:37 INFO - Running pre-action listener: _resource_record_pre_action 18:12:37 INFO - Running main action method: install 18:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:37 INFO - Reading from file tmpfile_stdout 18:12:37 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:37 INFO - Reading from file tmpfile_stdout 18:12:37 INFO - Output received: 18:12:37 INFO - Usage: mozinstall [options] installer 18:12:37 INFO - Options: 18:12:37 INFO - -h, --help show this help message and exit 18:12:37 INFO - -d DEST, --destination=DEST 18:12:37 INFO - Directory to install application into. [default: 18:12:37 INFO - "/builds/slave/test"] 18:12:37 INFO - --app=APP Application being installed. [default: firefox] 18:12:37 INFO - mkdir: /builds/slave/test/build/application 18:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:12:53 INFO - Reading from file tmpfile_stdout 18:12:53 INFO - Output received: 18:12:53 INFO - /builds/slave/test/build/application/firefox/firefox 18:12:53 INFO - Running post-action listener: _resource_record_post_action 18:12:53 INFO - [mozharness: 2016-07-31 01:12:53.960222Z] Finished install step (success) 18:12:53 INFO - [mozharness: 2016-07-31 01:12:53.960497Z] Running run-tests step. 18:12:53 INFO - Running pre-action listener: _resource_record_pre_action 18:12:53 INFO - Running main action method: run_tests 18:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:53 INFO - Python 2.7.3 18:12:53 INFO - Return code: 0 18:12:53 INFO - grabbing minidump binary from tooltool 18:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:53 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 0x24d23b0>, '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 0x24d32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:12:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:12:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:12:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:54 INFO - Return code: 0 18:12:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:12:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:12:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:54 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/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 18:12:54 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/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 18:12:54 INFO - Using env: {'DISPLAY': ':0', 18:12:54 INFO - 'HOME': '/home/cltbld', 18:12:54 INFO - 'LANG': 'en_US.UTF-8', 18:12:54 INFO - 'LANGUAGE': 'en_US:en', 18:12:54 INFO - 'LOGNAME': 'cltbld', 18:12:54 INFO - 'MAIL': '/var/mail/cltbld', 18:12:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:54 INFO - 'MOZ_NO_REMOTE': '1', 18:12:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:54 INFO - 'NO_EM_RESTART': '1', 18:12:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:54 INFO - 'PWD': '/builds/slave/test', 18:12:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:54 INFO - 'SHELL': '/bin/bash', 18:12:54 INFO - 'SHLVL': '1', 18:12:54 INFO - 'TERM': 'linux', 18:12:54 INFO - 'TMOUT': '86400', 18:12:54 INFO - 'USER': 'cltbld', 18:12:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859', 18:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:54 INFO - '_': '/tools/buildbot/bin/python'} 18:12:54 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/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 18:12:54 INFO - mozversion application_buildid: 20160730165725 18:12:54 INFO - mozversion application_changeset: c761bfb5fd83eb0d767adbf34012b7dda384dce9 18:12:54 INFO - mozversion application_display_name: Nightly 18:12:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:54 INFO - mozversion application_name: Firefox 18:12:54 INFO - mozversion application_remotingname: firefox 18:12:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:12:54 INFO - mozversion application_vendor: Mozilla 18:12:54 INFO - mozversion application_version: 50.0a1 18:12:54 INFO - mozversion platform_buildid: 20160730165725 18:12:54 INFO - mozversion platform_changeset: c761bfb5fd83eb0d767adbf34012b7dda384dce9 18:12:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:12:54 INFO - mozversion platform_version: 50.0a1 18:12:54 INFO - using testdate: 1469927574 18:12:54 INFO - actual date: 1469927574 18:12:54 INFO - starting webserver on 'localhost:56507' 18:12:54 INFO - SUITE-START | Running 2 tests 18:12:54 INFO - TEST-START | dromaeo_css 18:12:54 INFO - operating with platform_type : linux_ 18:12:54 INFO - Initialising browser for dromaeo_css test... 18:12:54 INFO - TEST-INFO | started process 20869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBcft4E/profile http://localhost:56507/getInfo.html) 18:12:58 INFO - PROCESS | 20869 | __metrics Screen width/height:1600/1200 18:12:58 INFO - PROCESS | 20869 | colorDepth:24 18:12:58 INFO - PROCESS | 20869 | Browser inner width/height: 1024/697 18:12:58 INFO - PROCESS | 20869 | __metrics 18:12:59 INFO - PROCESS | 20869 | 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" 18:12:59 INFO - PROCESS | 20869 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:13:00 INFO - TEST-INFO | 20869: exit 0 18:13:00 INFO - Browser initialized. 18:13:00 INFO - Running cycle 1/1 for dromaeo_css test... 18:13:00 INFO - TEST-INFO | started process 20948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBcft4E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:11 INFO - PROCESS | 20948 | RSS: Main: 157372416 18:13:11 INFO - PROCESS | 20948 | 18:14:04 INFO - PROCESS | 20948 | 1469927644033 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:16:15 INFO - PROCESS | 20948 | Cycle 1(1): loaded http://localhost:56507/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56507/tests/dromaeo/cssquery-ext.html) 18:16:16 INFO - PROCESS | 20948 | RSS: Main: 248115200 18:16:16 INFO - PROCESS | 20948 | 18:19:19 INFO - PROCESS | 20948 | Cycle 1(1): loaded http://localhost:56507/tests/dromaeo/cssquery-ext.html (next: http://localhost:56507/tests/dromaeo/cssquery-jquery.html) 18:19:20 INFO - PROCESS | 20948 | RSS: Main: 246267904 18:19:20 INFO - PROCESS | 20948 | 18:22:22 INFO - PROCESS | 20948 | Cycle 1(1): loaded http://localhost:56507/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56507/tests/dromaeo/cssquery-mootools.html) 18:22:22 INFO - PROCESS | 20948 | RSS: Main: 189243392 18:22:22 INFO - PROCESS | 20948 | 18:25:25 INFO - PROCESS | 20948 | Cycle 1(1): loaded http://localhost:56507/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56507/tests/dromaeo/cssquery-prototype.html) 18:25:25 INFO - PROCESS | 20948 | RSS: Main: 193028096 18:25:25 INFO - PROCESS | 20948 | 18:28:28 INFO - PROCESS | 20948 | Cycle 1(1): loaded http://localhost:56507/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56507/tests/dromaeo/cssquery-yui.html) 18:28:29 INFO - PROCESS | 20948 | RSS: Main: 189140992 18:28:29 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | Cycle 1(1): loaded http://localhost:56507/tests/dromaeo/cssquery-yui.html (next: http://localhost:56507/tests/dromaeo/cssquery-dojo.html) 18:31:32 INFO - PROCESS | 20948 | RSS: Main: 285659136 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | __start_tp_report 18:31:32 INFO - PROCESS | 20948 | _x_x_mozilla_page_load 18:31:32 INFO - PROCESS | 20948 | _x_x_mozilla_page_load_details 18:31:32 INFO - PROCESS | 20948 | |i|pagename|runs| 18:31:32 INFO - PROCESS | 20948 | |0;dojo.html;2635.0250407349276;2653.668291463567;2674.531956907542;2686.516427043133;2689.69068557116;4625.930611040829;4675;4766.285057241415;4810.254410566364;4818.927716084258;4690.718556886581;4710.199266124759;4742.430908291001;4747.026859493804;4764.118638051954;4234.237837189305;4248.702590818644;4295.484541854966;4352.412424322708;4415.183191109655;4340.7395556266565;4373.234683930315;4402.515723270438;4414.911701765963;4418.028033832552;4205.705600607958;4247.723897946624;4362.781860906974;4371.9507318243395;4473.2171869922795;4260.9147817043795;4298.226319262531;4316.395704601358;4318.287482565404;4342.956570434287;4274.935875961863;4321.7406955582765;4325.5025672047805;4333.155034768221;4371.038371558252;4586.082783443325;4702.623790096784;4757.833475828329;4800.3759511263315;4808.543188397097;5000.349954505928;5039.269305950654;5055.797768089272;5122.3853137623355;5124.923126153073;5096.694198348074;5110.897782044338;5141.357330333708;5148.974255128738;5160.974195129001;4680.602148817388;4695.413073365863;4740.26525888481;4757.09615173116;4759.881002974953;5193.065248255275;5223.190405487156;5256.842294731164;5271.683698978073;5273.31446911899;4974.27872958419;4984.501549844987;5039.496050395004;5040.168372218616;5085.618578606619;4885.780139893714;4997.9750101249265;5088.414832294259;5152.768125434364;5158.871028224325;5043.899122017539;5108.080545501771;5108.412532558729;5152.175651895754;5155.871103222449;5061.670991385622;5064;5072.467390923974;5078.97460512695;5122.820701275437;4197.706160568731;4248.532661407243;4328.7402755834755;4343.109662519176;4377.037051848588;3708.49935258742;3712.443133529938;3734.626537346244;3773;3830.559485659129;4353.499347575006;4357.063231405263;4359.17175736609;4395.362672412482;4398.296272596369;4967.205247160509;5094.796208151706;5096.643234973591;5096.9490305097215;5140.820071297487;4299.204647140226;4304;4322.37325587788;4369.300911854088;4420.84527041552;4536.455625324982;4569.451665800058;4573.588377046081;4576.336431217522;4621.838235661803;4812.975935120302;4817.638677099161;4819.95180048195;4825.0349930013435;4868.464468908346;4916.680415772963;5062.822801202087;5093.694378337312;5095.439501654889;5160.406553246275;4813.302071199586;4833.516648335279;4840.6127509798425;4851.499925376903;4880.194767863263;4967.3542439482635;5009.574186194214;5020;5021.171506701354;5064.392272927125;4931.50684931504;5006.148954677641;5064.4935506449065;5083.669561478492;5144.202648589475;4895.975520122377;4908.190148625579;4915.4592994771265;4918.704877707206;4963.851084467472;4902.117618828645;4904.8773780655765;4910.729909854992;4913.140200464833;4960.454350021422;4706.199946009118;4779.450363208275;4825.203841366276;4840.8789780254365;4894.632902532396;4989.950100498949;4997.750112494434;5011.173156429294;5020.297158397754;5059.038782631288;4881.707097574157;4897.2654101885;4897.534734200245;4904.558589726942;4950 18:31:32 INFO - PROCESS | 20948 | |1;ext.html;557.108626198083;573.1288441568815;575.9164921086441;581.7120525339957;587.7795826565039;27074.187774366776;29711.40577188455;40968.59031409689;42213;42352;41223.58776412235;41656.37515437263;41660;41700.16599668005;41726;7774.0671119465605;7924.881126783102;7926.762197134095;7928.405369597274;7934.404919631022;7437;9879.06148915852;10057.044580764852;10104.595816167344;10462.947685261563;10228.846567301496;10321.793564128751;10330.690079297634;10334.276600637959;10335.896641033569;10185.439800810953;10227;10255.384676919408;10258.9487052565;10259.640912568098;10062.79874402515;10154.593816247341;10156.746081347952;10159.441230732307;10163.644272450429;38044.80977595122;38131.42802857959;38269.80865095657;38272;38336.42495362572;3080.383923215366;3086.151308390188;3152.8423578820966;3174.238182836126;3387.44107222308;29447.70552294471;30073.248168795955;30149;30175.245618859484;30226.093217203517;3427.8971630851115;3562.109472631842;3649.489071529988;3692.46459263408;3698.33429982603;252675;254342;254442;254645;254666;55541.16688249679;55610.72194639082;55852.16221756677;55863;55983.44016559864;57048.71475642678;57061;57225.14162287569;57297.427025730045;57375.71312143496;15061.397544098114;15304.846951530342;15321.770173447407;15331.156786376634;15338.616534586501;9441.386309889835;9678.419294842332;11725.472353744102;11860.051195904307;11860.584879529175;16268.26792794327;16427;16677.416290429777;17182.74225886613;17320;5796.82609521715;5838.79564215259;5918.201042859245;6008.939910600925;6021.789237376671;825.6367198432671;849.1169184048644;884.1539304027557;926.2312280806914;1020.3163880200284;27747.265103773356;27881.72118278832;27995.580066299022;28338.858305708338;28575.71424285772;876.2726936642572;919.595378033663;943.5612440215333;955.2978560757838;968.7820240445843;14669.633259168606;14752.20668674771;14818.33317500715;14874.980092371405;15075.321610527553;373864;377310;377374;377994;653602;50374;51389.486105139214;51392;56714.432855670915;56730;1142.582957220625;1153.901918336934;1176.2942234659135;1180.4982882275172;1183.207251141737;28211.294717632223;29656.258593535335;29699.406011880073;30208.848955755082;30255.546166807955;44605.33092003558;44991.77504112459;45077.77461112673;45084.32373514466;45090.77454612706;279915;279921;279973;280178;280514;36762.63237367699;37642.43536347012;37757.244855102195;38022.09889505569;38154.42768358421;41830.58169418267;42242;42621.14757704767;43139.784301078296;43377;36131.45802812908;36565.45151822778;36647.08382290464;37232.81383593065;37299.62700372961;36026.63973360233;36133.81933090318;36187.81906090558;36882.26235475329;36961.26077478489;35243.47134793032;35407.46888796722;36149.09627259339;36315.27369452544;36559.45160822537;31320.21699457532;33194.66805332012;33287.83356083204;33765.493517597744;33878.3224335507;25298.620520691835;25498.872505638094;25660.743392565837;25970;26030 18:31:32 INFO - PROCESS | 20948 | |2;jquery.html;339.96770306820844;357.5173515753734;359.94060979938314;362.7623906341346;389.48587864019487;12823.935880320609;15955.441559545417;16221.594460138502;17134.31462741489;18108.094595270217;17156.39952601659;17202.913985430056;17269.222884970175;17422.128893555335;17549.122543872818;4884.5848102911295;4915.483874193212;5098.286239926413;5138.434772175057;5139;3697.0757310672334;5006.924896126561;5119.974400127994;5640.153976903477;5955.285365756115;5932.199153114318;5982.700864956757;5994.670293133898;5994.940050599504;5996.640201587918;5209.479052094817;5427.701476418795;5447.591430642718;5538.889222215533;5974.193483879664;5355.357357117132;5358.91961620576;5361.946380536223;5365.7585408656705;5366.4633536646415;12175.939120304341;12437.502499899992;12460.501579936792;12584.81122783159;12769.042321825807;1764.6558921010408;1861.3764388929724;1980.8910509921948;2071.30611245233;2257.796798288162;9140.131687489678;9603.903960960371;9609.183219426357;9735.318527703064;12555.874441255562;1701.6851882401672;1720.4838548435544;1738.5219064757293;1768.6285879965224;1849.9075046247633;64765.35234647687;65697.67151164214;65973.34026659768;69260;69307.99999999949;10079.596816127272;10248.026437488426;10251.179905607534;10420.593219915214;10505.636231847926;11063.446827658585;13932.024758266823;13936.651583710285;13944.651383715489;13970.930145349208;6919.100516932766;6927.376536111774;6998.860022799618;7317.707291708379;7326.487145899842;6682.933170668328;6962.477814163958;7043.788686339418;7392.55644661322;7416.666250018762;3697.4084146536425;3818.198178382571;3821.1975485147873;3865.9613403866165;3962.5641179470235;1784.6787578235783;1870.436135828574;1876.55900863297;1914.7989461106663;1953.1113343428706;767.861784878716;844.2275318084007;875.1336177184542;877.3726785348506;897.8731691726972;16612;16703;16944.322227110777;17340;17915.37296194653;829.2536716954669;850.5704619167404;861.3841103610948;903.4850135422878;905.9139381758722;9488.525573721286;9805.509724513746;9971.601135954626;10018.549165287579;10179.338343007681;409752.6098956008;411206;411864;413111;413507;49317.50682493201;62888.05667914893;83219.16780832235;85384;85730;897.1432282170512;902.5397047505819;902.7923577577194;906.6101576322113;909.5543183840003;14937.103773773608;15315.693686126438;15332;15474.5357639271;16075.874688771673;37666.811665942594;39679;39938.80030599829;40053.59946400499;40415.797921010206;48765.5123448761;49534;51616.22575661293;58903.705481472316;59131;7572.924270757442;7743.690252389842;7846.215378462108;7923.564203968837;8091;9098.681546145854;11648.941755291507;11790.882091178979;12375.69060773488;12709.364531773559;10188.643397481053;10287.124360613596;10367.185742494883;10782.568697252336;10928.945355273172;10570;10700.785984280115;10874.135780071909;10942.617008404668;11011.394373309224;9608.327417080738;10167.79664406693;10508.264421490423;10632.25574209798;10824.296420732628;7550.509216900884;7835.294823465915;7974.322182614543;8035.397345199251;8065.395095367753;10407.271490995861;10859.619913302997;10866.61966831157;11035.724106897393;11460.885391145981 18:31:32 INFO - PROCESS | 20948 | |3;mootools.html;1227.404708716273;1288.6713887958572;1349.1500354776492;1365.3651052260702;1658.6682663467302;6308.810735677931;7295.343419092287;7501.43739219558;7526.510776799504;7756.728514501993;7597.202293759158;7641.503302285348;7651.387888968883;7655.387568994481;7660.846783064336;2162.145952348821;2190.5290362572046;2191.3097374327117;2194.2868567715554;2195.4401627584944;2117.3224568138126;2157.7518585362727;2176.3688530326185;2177.586258610867;2180.8364372672036;2118.7775283595233;2135.4341099608614;2142.9785702143013;2143.4212762554102;2162.805347518723;2115.185653523397;2116.2593092417683;2117.280124757582;2118.4174352053233;2119.7244358233484;2084.155916853677;2138.6791981202787;2139.304725964068;2142.239504975727;2142.6571748520164;7150;7530.096388433423;7574.3183113520045;7638.541687498712;7639.9236007639765;4466;4641.651876109271;4645.558671926162;4656.650751193674;4663.533646635343;2787.3031742064486;2952.1733914503975;2968.2430980100153;2989.282572182682;3011.6988301169927;887.9778005549848;895.3016647015338;899.4917871402637;911.334725650279;911.6490151291734;10146.086852183265;10236.129928956048;10251.48742562869;10259.743506412326;10261.333013354182;3773.509443772292;3999.7400168988925;4063.878083657495;4098.364753463218;4100.446439730598;8222.671093156327;8226.218509241613;8226.506409615442;8231.34149268057;8239.340852731768;4549.954500455019;4553.977230113828;4554.43069616298;4564.42944631921;4564.885877853014;3607.458881167846;3706.5737440194184;4090.468239128954;4242.766647834337;4247.97876010618;3415.26571787067;3451.154467155563;3549.4498352755363;3560.412531932254;3588.085038315213;1059.142094903131;1064.9254552181428;1071.8499410082595;1085.1969542538623;1094.3871431998107;757.5492581913752;762.2567996203768;802.9397795165386;821.7904434369198;844.8690452979798;5415.512603865593;5474.206240095164;5485.61600687948;5490.917636235459;5521;825.2984962781587;841.2680967558264;868.5309932636305;872.3283072034498;877.2937785082942;3590.8204589770407;3652.6164752701116;3666.156783939709;3736.9439458408146;3802.9429558556644;9158.542072896462;9543.093406126407;9557.808843823084;9568.282378821616;9586.328956972944;9492.952535237418;9522.428654280766;9534.713958581253;9539.904600953902;9564.61741530331;7099.467539934422;7269.927300726925;7273;7291.598962057138;7295.051643286339;5136.409312928911;5169.767360468863;5187.170052791535;5280.445553216857;5531.419200984;8428.747137585882;8602.268807151462;8747.868781968149;8751.124887511198;8806;8553.74338769838;8794.868076978722;8843.513606751432;8854.513001784964;8854.734357969272;5683.744231509675;6388.93611063902;6400.647964362005;6674.733010679518;6705.295943926013;7087.858242835217;7141.392981596622;7327.2672732726305;7329.560226386434;7334.633268336455;6314.273858506331;6346.397092276226;6423.42189202974;6549.443297319781;6626.27111017778;6653.334666533308;6654.467642588678;6673;6680.298568650416;6692.899606505809;6247.468965138014;6352.555321127476;6371.681415929278;6382.90425643625;6385.201849768779;4441.0895766367175;4522;4727.314539391838;4749.857504274877;4778.331033655221;4615.653825963133;4643.373144625568;4701.435827700698;4743.45450273223;4914.36113305268 18:31:32 INFO - PROCESS | 20948 | |4;prototype.html;276.12330849552677;286.0973628203019;292.4939854052488;293.17325143096474;295.7382716296078;4878.170710979133;4918.926216106761;4919.901601967958;4922.064807686537;4952.554270115689;4569.01247957138;4691.577758001779;4770.594499467549;4793.568578827905;4883.536064073907;3784.110733977513;3785.902088394362;3806.9428958565645;3818.770873747584;3829.8468061277586;3793.222389410178;3811.6378944000276;3812.8284227209842;3821.675157611606;3843.0584506795876;3602.9823298952538;3644.7266455015847;3766;3768.5666148392875;3778.1310298631333;3737.2338670572603;3744.8314825832904;3788.3181027415053;3789.829457674411;3799.6960243180615;3328.400887840188;3332.4001679697644;3334.3498017886523;3339.1819004344093;3344.5317655528247;4523.855920135507;4761.904761904742;4791.329213910055;4793;4812.663113582051;4261.786910654455;4297.828086876552;4303.935440968388;4305.3326734355915;4306.7631280279575;5121.769520371555;5125.564327032207;5130.230465430178;5133.12736834739;5161.7161056141895;3564.055525285801;3567.678908898212;3571.482135090397;3579.6062433132333;3585.2470981094;5225.686458812484;5278.498542638443;5303.7348132593215;5320.228566857822;5324.600654950856;3625.546806649169;3637.1452708613456;3637.3270944875285;3658.63413658632;3672.247189326182;3708.554973403209;3718.6839118674675;3719.6609220680534;3720.720945929066;3724.5902950675404;4120.896977575585;4240.494624408352;4281.7645029523055;4282.957170428318;4288.292431748727;5047.369078865142;5048.697078175322;5059.165237735732;5061.417936937226;5068.935523540098;1220.992681038147;1250.1498980693034;1251.205484517338;1258.4148371007525;1265.6013355792895;808.6603626476893;808.9474184178009;852.5907564369138;868.0538213347481;875.6847534887436;4430.645548356124;4432.15789000089;4441;4443.488998765119;4445.488768791565;5160.380754309507;5164.406093299319;5172.663776854492;5181.922271165936;5184.5593124584075;4243.427137336482;4448.177087238806;4469.374287599739;4471.329300604935;4479.776011199492;2732.5081485332435;2740.7122252163235;2744.0807329544828;2746.9038583649476;2781.9860900695367;4841.031793641286;4854.296127061556;4864.756762161877;4883.121038213085;4897.2654101885;5084.56781173597;5251.238570407269;5254.029738847932;5258.553022993012;5271.970291437824;4876.853694389174;4882.145624515767;4906.2640603909695;4907.55831975124;4908.950910490992;5181.896362072813;5185.688858668492;5194.337811900306;5197;5200.947990520046;4909.7545122743;5079.5428411443145;5101.413337466239;5142.5885929126325;5153.561947234527;4950.455449900436;4964.503549645006;4973.825916092919;4989.301497790385;4993.850184494471;3683.576388715332;3750.7374483785875;3762.097096696828;3769.3215221260434;3771.283456143324;5118.539331460186;5296.973515132554;5325.201219816903;5334.226537152169;5344.305240318734;5080.923786143285;5103.617228707936;5106.131957567297;5111.667741596784;5112.769925353442;5063.215201643751;5078.695278283315;5100.26046223303;5105.2342148678;5115;4843;4933.975330123327;4946.332245146859;4976.412265621929;5000.14997450427;4908.141075311878;5082.593392528663;5107.693538387709;5109.335786347751;5134.460881607527;4893.290472881341;4946.653734238569;4984.950150498448;5060.089183946925;5064.848054558369 18:31:32 INFO - PROCESS | 20948 | |5;yui.html;604.2145211225409;611.1352436302632;616.0337972661633;686.6841253023612;735.6358602491767;12746.362681865905;13754.174749515036;13754.381052852621;13758.724825503485;13759.65600859979;11470.7132321692;11504.597339093134;11541.134414918894;11587.130965177603;13150;776.1578687124477;794.5351969098084;799.1089934722771;799.4963173200875;799.9400044996648;792.6512334572799;796.108358638323;796.5380079553845;796.5499492786586;796.9163237860029;836.0469065265602;837.476577139288;837.7277384849948;837.9162083791603;837.9832403351929;828.867381219008;829.5727700234354;831.0692024932084;831.6008316008289;832.0306842528447;606.4511616986634;606.4632799972056;606.7845914700306;606.7967230977583;606.8240210338996;12495.875041249654;12498.875011249862;12524.185927914656;12525.812112818316;12535.561255356019;12782.488700451971;12929.353532323346;13065.673358166026;13205.33973301331;13370.866291337157;9797.167240784542;9804.607815687365;9850.594835475275;9951.232109335377;9975.251856110748;3314.7016768490953;3324.4847048707247;3351.5307856900054;3360.9663903360897;3374.645662205482;41676.79161604172;53417.1987420189;59576.40423595752;61301.6934915327;62849.371506285264;10378.325408848401;10433.530491127918;10466.476676166314;10550.788984220273;10688.14494840411;18893.055347232585;18928.526786830163;18937.14782834776;18947.905260473886;18948.526286842938;6980.755673551402;6985.26654701249;7038.577685338896;7155.427565794724;7210.67551960163;3749.9062523437133;3836.635519625631;3877.9612203878164;3949.9927518482605;3983.6215559521797;2899.1882272963603;3013.0659495556447;3022.335086281015;3023.3046399328277;3024.1834704629628;489.5104895104895;504.85611600693625;510.1276816643581;511.98976020480126;542.6310109125832;537.9462053794589;566.2553741829481;575.9913601295984;581.5580159079046;596.4155127974609;8042.718504852302;8120.14738452454;8394.202550757669;8449.788755281168;8613.913860861312;443.99778001109786;471.4554689333825;475.7070918174366;570.6091327440716;590.8641012567134;3778.414345776354;3931.312020396419;3947.2302900934615;3952.2885880541203;4165.479315085614;55724;58697;96361.51819240859;96915.51542242385;96990.51504742431;77785.2221477778;78197.21802781899;79150.6042469784;79857;81395;41782.582174178475;42974.57025429768;68764.6561767188;70231.29768702248;72963;8250.46371985819;8400.789980250544;8457.915420845713;8798.604062817316;8841;29622.259443514085;38518.037049072875;38865.805670971466;39394.6060539391;43526;40737.59262407457;41298.79350603348;45392;59729;60491.39508604858;10621.787564248827;10664.946675266885;10835.51240194209;10912.290701104403;11412.71468213268;12237.938810306248;12348.876511234772;12617.81073283883;13210.405531750903;13247.470101195844;10743.409112498888;11224.607138750105;11297.43512824372;11299.774004520028;11357.943210283896;10728.034476897117;10917.727056823644;11002.50488728025;11657.825132622847;11664.94167529157;10361.896381036093;10660.360378377321;10808.621698240524;11049.834252486058;11201.719957000814;9485.193758530602;9929.31119513391;10239.612490818577;10337.328073675188;10423.270371073952;9131.589078491352;9768.36505627132;9893.109620134222;9989.900100999188;10068 18:31:32 INFO - PROCESS | 20948 | __end_tp_report 18:31:32 INFO - PROCESS | 20948 | __start_cc_report 18:31:32 INFO - PROCESS | 20948 | _x_x_mozilla_cycle_collect,1020 18:31:32 INFO - PROCESS | 20948 | __end_cc_report 18:31:32 INFO - PROCESS | 20948 | __startTimestamp1469928692554__endTimestamp 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | ------- Summary: start ------- 18:31:32 INFO - PROCESS | 20948 | Number of tests: 6 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | [#0] dojo.html Cycles:165 Average:4690.04 Median:4825.20 stddev:498.54 (10.3%) stddev-sans-first:473.29 18:31:32 INFO - PROCESS | 20948 | Values: 2635.0 2653.7 2674.5 2686.5 2689.7 4625.9 4675.0 4766.3 4810.3 4818.9 4690.7 4710.2 4742.4 4747.0 4764.1 4234.2 4248.7 4295.5 4352.4 4415.2 4340.7 4373.2 4402.5 4414.9 4418.0 4205.7 4247.7 4362.8 4372.0 4473.2 4260.9 4298.2 4316.4 4318.3 4343.0 4274.9 4321.7 4325.5 4333.2 4371.0 4586.1 4702.6 4757.8 4800.4 4808.5 5000.3 5039.3 5055.8 5122.4 5124.9 5096.7 5110.9 5141.4 5149.0 5161.0 4680.6 4695.4 4740.3 4757.1 4759.9 5193.1 5223.2 5256.8 5271.7 5273.3 4974.3 4984.5 5039.5 5040.2 5085.6 4885.8 4998.0 5088.4 5152.8 5158.9 5043.9 5108.1 5108.4 5152.2 5155.9 5061.7 5064.0 5072.5 5079.0 5122.8 4197.7 4248.5 4328.7 4343.1 4377.0 3708.5 3712.4 3734.6 3773.0 3830.6 4353.5 4357.1 4359.2 4395.4 4398.3 4967.2 5094.8 5096.6 5096.9 5140.8 4299.2 4304.0 4322.4 4369.3 4420.8 4536.5 4569.5 4573.6 4576.3 4621.8 4813.0 4817.6 4820.0 4825.0 4868.5 4916.7 5062.8 5093.7 5095.4 5160.4 4813.3 4833.5 4840.6 4851.5 4880.2 4967.4 5009.6 5020.0 5021.2 5064.4 4931.5 5006.1 5064.5 5083.7 5144.2 4896.0 4908.2 4915.5 4918.7 4963.9 4902.1 4904.9 4910.7 4913.1 4960.5 4706.2 4779.5 4825.2 4840.9 4894.6 4990.0 4997.8 5011.2 5020.3 5059.0 4881.7 4897.3 4897.5 4904.6 4950.0 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | [#1] ext.html Cycles:180 Average:48667.41 Median:36141.46 stddev:89294.08 (247.1%) stddev-sans-first:89471.51 18:31:32 INFO - PROCESS | 20948 | Values: 557.1 573.1 575.9 581.7 587.8 27074.2 29711.4 40968.6 42213.0 42352.0 41223.6 41656.4 41660.0 41700.2 41726.0 7774.1 7924.9 7926.8 7928.4 7934.4 7437.0 9879.1 10057.0 10104.6 10462.9 10228.8 10321.8 10330.7 10334.3 10335.9 10185.4 10227.0 10255.4 10258.9 10259.6 10062.8 10154.6 10156.7 10159.4 10163.6 38044.8 38131.4 38269.8 38272.0 38336.4 3080.4 3086.2 3152.8 3174.2 3387.4 29447.7 30073.2 30149.0 30175.2 30226.1 3427.9 3562.1 3649.5 3692.5 3698.3 252675.0 254342.0 254442.0 254645.0 254666.0 55541.2 55610.7 55852.2 55863.0 55983.4 57048.7 57061.0 57225.1 57297.4 57375.7 15061.4 15304.8 15321.8 15331.2 15338.6 9441.4 9678.4 11725.5 11860.1 11860.6 16268.3 16427.0 16677.4 17182.7 17320.0 5796.8 5838.8 5918.2 6008.9 6021.8 825.6 849.1 884.2 926.2 1020.3 27747.3 27881.7 27995.6 28338.9 28575.7 876.3 919.6 943.6 955.3 968.8 14669.6 14752.2 14818.3 14875.0 15075.3 373864.0 377310.0 377374.0 377994.0 653602.0 50374.0 51389.5 51392.0 56714.4 56730.0 1142.6 1153.9 1176.3 1180.5 1183.2 28211.3 29656.3 29699.4 30208.8 30255.5 44605.3 44991.8 45077.8 45084.3 45090.8 279915.0 279921.0 279973.0 280178.0 280514.0 36762.6 37642.4 37757.2 38022.1 38154.4 41830.6 42242.0 42621.1 43139.8 43377.0 36131.5 36565.5 36647.1 37232.8 37299.6 36026.6 36133.8 36187.8 36882.3 36961.3 35243.5 35407.5 36149.1 36315.3 36559.5 31320.2 33194.7 33287.8 33765.5 33878.3 25298.6 25498.9 25660.7 25970.0 26030.0 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | [#2] jquery.html Cycles:180 Average:24747.05 Median:40234.70 stddev:67862.71 (168.7%) stddev-sans-first:68028.33 18:31:32 INFO - PROCESS | 20948 | Values: 340.0 357.5 359.9 362.8 389.5 12823.9 15955.4 16221.6 17134.3 18108.1 17156.4 17202.9 17269.2 17422.1 17549.1 4884.6 4915.5 5098.3 5138.4 5139.0 3697.1 5006.9 5120.0 5640.2 5955.3 5932.2 5982.7 5994.7 5994.9 5996.6 5209.5 5427.7 5447.6 5538.9 5974.2 5355.4 5358.9 5361.9 5365.8 5366.5 12175.9 12437.5 12460.5 12584.8 12769.0 1764.7 1861.4 1980.9 2071.3 2257.8 9140.1 9603.9 9609.2 9735.3 12555.9 1701.7 1720.5 1738.5 1768.6 1849.9 64765.4 65697.7 65973.3 69260.0 69308.0 10079.6 10248.0 10251.2 10420.6 10505.6 11063.4 13932.0 13936.7 13944.7 13970.9 6919.1 6927.4 6998.9 7317.7 7326.5 6682.9 6962.5 7043.8 7392.6 7416.7 3697.4 3818.2 3821.2 3866.0 3962.6 1784.7 1870.4 1876.6 1914.8 1953.1 767.9 844.2 875.1 877.4 897.9 16612.0 16703.0 16944.3 17340.0 17915.4 829.3 850.6 861.4 903.5 905.9 9488.5 9805.5 9971.6 10018.5 10179.3 409752.6 411206.0 411864.0 413111.0 413507.0 49317.5 62888.1 83219.2 85384.0 85730.0 897.1 902.5 902.8 906.6 909.6 14937.1 15315.7 15332.0 15474.5 16075.9 37666.8 39679.0 39938.8 40053.6 40415.8 48765.5 49534.0 51616.2 58903.7 59131.0 7572.9 7743.7 7846.2 7923.6 8091.0 9098.7 11648.9 11790.9 12375.7 12709.4 10188.6 10287.1 10367.2 10782.6 10928.9 10570.0 10700.8 10874.1 10942.6 11011.4 9608.3 10167.8 10508.3 10632.3 10824.3 7550.5 7835.3 7974.3 8035.4 8065.4 10407.3 10859.6 10866.6 11035.7 11460.9 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | [#3] mootools.html Cycles:180 Average:5023.12 Median:5479.91 stddev:2775.81 (50.7%) stddev-sans-first:2768.94 18:31:32 INFO - PROCESS | 20948 | Values: 1227.4 1288.7 1349.2 1365.4 1658.7 6308.8 7295.3 7501.4 7526.5 7756.7 7597.2 7641.5 7651.4 7655.4 7660.8 2162.1 2190.5 2191.3 2194.3 2195.4 2117.3 2157.8 2176.4 2177.6 2180.8 2118.8 2135.4 2143.0 2143.4 2162.8 2115.2 2116.3 2117.3 2118.4 2119.7 2084.2 2138.7 2139.3 2142.2 2142.7 7150.0 7530.1 7574.3 7638.5 7639.9 4466.0 4641.7 4645.6 4656.7 4663.5 2787.3 2952.2 2968.2 2989.3 3011.7 888.0 895.3 899.5 911.3 911.6 10146.1 10236.1 10251.5 10259.7 10261.3 3773.5 3999.7 4063.9 4098.4 4100.4 8222.7 8226.2 8226.5 8231.3 8239.3 4550.0 4554.0 4554.4 4564.4 4564.9 3607.5 3706.6 4090.5 4242.8 4248.0 3415.3 3451.2 3549.4 3560.4 3588.1 1059.1 1064.9 1071.8 1085.2 1094.4 757.5 762.3 802.9 821.8 844.9 5415.5 5474.2 5485.6 5490.9 5521.0 825.3 841.3 868.5 872.3 877.3 3590.8 3652.6 3666.2 3736.9 3802.9 9158.5 9543.1 9557.8 9568.3 9586.3 9493.0 9522.4 9534.7 9539.9 9564.6 7099.5 7269.9 7273.0 7291.6 7295.1 5136.4 5169.8 5187.2 5280.4 5531.4 8428.7 8602.3 8747.9 8751.1 8806.0 8553.7 8794.9 8843.5 8854.5 8854.7 5683.7 6388.9 6400.6 6674.7 6705.3 7087.9 7141.4 7327.3 7329.6 7334.6 6314.3 6346.4 6423.4 6549.4 6626.3 6653.3 6654.5 6673.0 6680.3 6692.9 6247.5 6352.6 6371.7 6382.9 6385.2 4441.1 4522.0 4727.3 4749.9 4778.3 4615.7 4643.4 4701.4 4743.5 4914.4 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | [#4] prototype.html Cycles:180 Average:4206.04 Median:4848.65 stddev:1228.98 (25.3%) stddev-sans-first:1196.51 18:31:32 INFO - PROCESS | 20948 | Values: 276.1 286.1 292.5 293.2 295.7 4878.2 4918.9 4919.9 4922.1 4952.6 4569.0 4691.6 4770.6 4793.6 4883.5 3784.1 3785.9 3806.9 3818.8 3829.8 3793.2 3811.6 3812.8 3821.7 3843.1 3603.0 3644.7 3766.0 3768.6 3778.1 3737.2 3744.8 3788.3 3789.8 3799.7 3328.4 3332.4 3334.3 3339.2 3344.5 4523.9 4761.9 4791.3 4793.0 4812.7 4261.8 4297.8 4303.9 4305.3 4306.8 5121.8 5125.6 5130.2 5133.1 5161.7 3564.1 3567.7 3571.5 3579.6 3585.2 5225.7 5278.5 5303.7 5320.2 5324.6 3625.5 3637.1 3637.3 3658.6 3672.2 3708.6 3718.7 3719.7 3720.7 3724.6 4120.9 4240.5 4281.8 4283.0 4288.3 5047.4 5048.7 5059.2 5061.4 5068.9 1221.0 1250.1 1251.2 1258.4 1265.6 808.7 808.9 852.6 868.1 875.7 4430.6 4432.2 4441.0 4443.5 4445.5 5160.4 5164.4 5172.7 5181.9 5184.6 4243.4 4448.2 4469.4 4471.3 4479.8 2732.5 2740.7 2744.1 2746.9 2782.0 4841.0 4854.3 4864.8 4883.1 4897.3 5084.6 5251.2 5254.0 5258.6 5272.0 4876.9 4882.1 4906.3 4907.6 4909.0 5181.9 5185.7 5194.3 5197.0 5200.9 4909.8 5079.5 5101.4 5142.6 5153.6 4950.5 4964.5 4973.8 4989.3 4993.9 3683.6 3750.7 3762.1 3769.3 3771.3 5118.5 5297.0 5325.2 5334.2 5344.3 5080.9 5103.6 5106.1 5111.7 5112.8 5063.2 5078.7 5100.3 5105.2 5115.0 4843.0 4934.0 4946.3 4976.4 5000.1 4908.1 5082.6 5107.7 5109.3 5134.5 4893.3 4946.7 4985.0 5060.1 5064.8 18:31:32 INFO - PROCESS | 20948 | 18:31:32 INFO - PROCESS | 20948 | [#5] yui.html Cycles:180 Average:15945.65 Median:22931.73 stddev:21951.89 (95.7%) stddev-sans-first:21983.24 18:31:32 INFO - PROCESS | 20948 | Values: 604.2 611.1 616.0 686.7 735.6 12746.4 13754.2 13754.4 13758.7 13759.7 11470.7 11504.6 11541.1 11587.1 13150.0 776.2 794.5 799.1 799.5 799.9 792.7 796.1 796.5 796.5 796.9 836.0 837.5 837.7 837.9 838.0 828.9 829.6 831.1 831.6 832.0 606.5 606.5 606.8 606.8 606.8 12495.9 12498.9 12524.2 12525.8 12535.6 12782.5 12929.4 13065.7 13205.3 13370.9 9797.2 9804.6 9850.6 9951.2 9975.3 3314.7 3324.5 3351.5 3361.0 3374.6 41676.8 53417.2 59576.4 61301.7 62849.4 10378.3 10433.5 10466.5 10550.8 10688.1 18893.1 18928.5 18937.1 18947.9 18948.5 6980.8 6985.3 7038.6 7155.4 7210.7 3749.9 3836.6 3878.0 3950.0 3983.6 2899.2 3013.1 3022.3 3023.3 3024.2 489.5 504.9 510.1 512.0 542.6 537.9 566.3 576.0 581.6 596.4 8042.7 8120.1 8394.2 8449.8 8613.9 444.0 471.5 475.7 570.6 590.9 3778.4 3931.3 3947.2 3952.3 4165.5 55724.0 58697.0 96361.5 96915.5 96990.5 77785.2 78197.2 79150.6 79857.0 81395.0 41782.6 42974.6 68764.7 70231.3 72963.0 8250.5 8400.8 8457.9 8798.6 8841.0 29622.3 38518.0 38865.8 39394.6 43526.0 40737.6 41298.8 45392.0 59729.0 60491.4 10621.8 10664.9 10835.5 10912.3 11412.7 12237.9 12348.9 12617.8 13210.4 13247.5 10743.4 11224.6 11297.4 11299.8 11357.9 10728.0 10917.7 11002.5 11657.8 11664.9 10361.9 10660.4 10808.6 11049.8 11201.7 9485.2 9929.3 10239.6 10337.3 10423.3 9131.6 9768.4 9893.1 9989.9 10068.0 18:31:32 INFO - PROCESS | 20948 | -------- Summary: end -------- 18:31:32 INFO - PROCESS | 20948 | 18:31:33 INFO - TEST-INFO | 20948: exit 0 18:31:33 INFO - TEST-OK | dromaeo_css | took 1119192ms 18:31:33 INFO - TEST-START | kraken 18:31:33 INFO - operating with platform_type : linux_ 18:31:33 INFO - Initialising browser for kraken test... 18:31:33 INFO - TEST-INFO | started process 21139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7yhGT/profile http://localhost:56507/getInfo.html) 18:31:37 INFO - PROCESS | 21139 | __metrics Screen width/height:1600/1200 18:31:37 INFO - PROCESS | 21139 | colorDepth:24 18:31:37 INFO - PROCESS | 21139 | Browser inner width/height: 1024/697 18:31:37 INFO - PROCESS | 21139 | __metrics 18:31:38 INFO - PROCESS | 21139 | 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" 18:31:38 INFO - PROCESS | 21139 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:31:39 INFO - TEST-INFO | 21139: exit 0 18:31:39 INFO - Browser initialized. 18:31:39 INFO - Running cycle 1/1 for kraken test... 18:31:39 INFO - TEST-INFO | started process 21221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7yhGT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:51 INFO - PROCESS | 21221 | RSS: Main: 157204480 18:31:51 INFO - PROCESS | 21221 | 18:31:53 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56507/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:54 INFO - PROCESS | 21221 | RSS: Main: 213295104 18:31:54 INFO - PROCESS | 21221 | 18:31:57 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56507/tests/kraken/driver.html?testName=audio-dft) 18:31:58 INFO - PROCESS | 21221 | RSS: Main: 192483328 18:31:58 INFO - PROCESS | 21221 | 18:32:01 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56507/tests/kraken/driver.html?testName=audio-fft) 18:32:01 INFO - PROCESS | 21221 | RSS: Main: 270295040 18:32:01 INFO - PROCESS | 21221 | 18:32:04 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56507/tests/kraken/driver.html?testName=audio-oscillator) 18:32:04 INFO - PROCESS | 21221 | RSS: Main: 180023296 18:32:04 INFO - PROCESS | 21221 | 18:32:06 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56507/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:32:07 INFO - PROCESS | 21221 | RSS: Main: 184713216 18:32:07 INFO - PROCESS | 21221 | 18:32:10 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56507/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:11 INFO - PROCESS | 21221 | RSS: Main: 221229056 18:32:11 INFO - PROCESS | 21221 | 18:32:14 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56507/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:15 INFO - PROCESS | 21221 | RSS: Main: 214306816 18:32:15 INFO - PROCESS | 21221 | 18:32:18 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56507/tests/kraken/driver.html?testName=json-parse-financial) 18:32:18 INFO - PROCESS | 21221 | RSS: Main: 217694208 18:32:18 INFO - PROCESS | 21221 | 18:32:20 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56507/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:21 INFO - PROCESS | 21221 | RSS: Main: 183902208 18:32:21 INFO - PROCESS | 21221 | 18:32:23 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:23 INFO - PROCESS | 21221 | RSS: Main: 189956096 18:32:23 INFO - PROCESS | 21221 | 18:32:25 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:26 INFO - PROCESS | 21221 | RSS: Main: 193937408 18:32:26 INFO - PROCESS | 21221 | 18:32:29 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:29 INFO - PROCESS | 21221 | RSS: Main: 189026304 18:32:29 INFO - PROCESS | 21221 | 18:32:32 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:33 INFO - PROCESS | 21221 | RSS: Main: 192217088 18:32:33 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:56507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56507/tests/kraken/driver.html?testName=ai-astar) 18:32:35 INFO - PROCESS | 21221 | RSS: Main: 243970048 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | __start_tp_report 18:32:35 INFO - PROCESS | 21221 | _x_x_mozilla_page_load 18:32:35 INFO - PROCESS | 21221 | _x_x_mozilla_page_load_details 18:32:35 INFO - PROCESS | 21221 | |i|pagename|runs| 18:32:35 INFO - PROCESS | 21221 | |0;ai-astar;104;116;114;114;113;113;114;113;115;115 18:32:35 INFO - PROCESS | 21221 | |1;audio-beat-detection;157;122;129;175;124;123;143;123;173;122 18:32:35 INFO - PROCESS | 21221 | |2;audio-dft;161;161;162;164;162;161;160;161;161;161 18:32:35 INFO - PROCESS | 21221 | |3;audio-fft;74;76;75;125;75;82;75;76;106;76 18:32:35 INFO - PROCESS | 21221 | |4;audio-oscillator;85;86;119;86;85;86;135;85;85;124 18:32:35 INFO - PROCESS | 21221 | |5;imaging-gaussian-blur;117;116;116;116;116;118;117;117;116;117 18:32:35 INFO - PROCESS | 21221 | |6;imaging-darkroom;146;147;147;147;146;147;146;146;145;147 18:32:35 INFO - PROCESS | 21221 | |7;imaging-desaturate;96;95;95;95;95;95;95;96;95;96 18:32:35 INFO - PROCESS | 21221 | |8;json-parse-financial;63;61;61;61;60;62;62;61;62;60 18:32:35 INFO - PROCESS | 21221 | |9;json-stringify-tinderbox;67;65;67;65;65;66;65;65;66;65 18:32:35 INFO - PROCESS | 21221 | |10;stanford-crypto-aes;90;82;78;85;79;89;81;79;78;81 18:32:35 INFO - PROCESS | 21221 | |11;stanford-crypto-ccm;140;134;135;132;127;129;131;129;173;132 18:32:35 INFO - PROCESS | 21221 | |12;stanford-crypto-pbkdf2;170;166;165;165;169;164;166;168;168;165 18:32:35 INFO - PROCESS | 21221 | |13;stanford-crypto-sha256-iterative;67;68;69;68;66;67;66;67;67;66 18:32:35 INFO - PROCESS | 21221 | __end_tp_report 18:32:35 INFO - PROCESS | 21221 | __start_cc_report 18:32:35 INFO - PROCESS | 21221 | _x_x_mozilla_cycle_collect,1920 18:32:35 INFO - PROCESS | 21221 | __end_cc_report 18:32:35 INFO - PROCESS | 21221 | __startTimestamp1469928755444__endTimestamp 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | ------- Summary: start ------- 18:32:35 INFO - PROCESS | 21221 | Number of tests: 14 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.35 (2.9%) stddev-sans-first:1.05 18:32:35 INFO - PROCESS | 21221 | Values: 104.0 116.0 114.0 114.0 113.0 113.0 114.0 113.0 115.0 115.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:136.00 stddev:21.62 (15.9%) stddev-sans-first:21.94 18:32:35 INFO - PROCESS | 21221 | Values: 157.0 122.0 129.0 175.0 124.0 123.0 143.0 123.0 173.0 122.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 18:32:35 INFO - PROCESS | 21221 | Values: 161.0 161.0 162.0 164.0 162.0 161.0 160.0 161.0 161.0 161.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:17.33 (23.0%) stddev-sans-first:18.00 18:32:35 INFO - PROCESS | 21221 | Values: 74.0 76.0 75.0 125.0 75.0 82.0 75.0 76.0 106.0 76.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:85.00 stddev:19.98 (23.5%) stddev-sans-first:20.66 18:32:35 INFO - PROCESS | 21221 | Values: 85.0 86.0 119.0 86.0 85.0 86.0 135.0 85.0 85.0 124.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 18:32:35 INFO - PROCESS | 21221 | Values: 117.0 116.0 116.0 116.0 116.0 118.0 117.0 117.0 116.0 117.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 18:32:35 INFO - PROCESS | 21221 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 145.0 147.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 18:32:35 INFO - PROCESS | 21221 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.50 stddev:0.95 (1.5%) stddev-sans-first:0.78 18:32:35 INFO - PROCESS | 21221 | Values: 63.0 61.0 61.0 61.0 60.0 62.0 62.0 61.0 62.0 60.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 18:32:35 INFO - PROCESS | 21221 | Values: 67.0 65.0 67.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.50 stddev:4.39 (5.4%) stddev-sans-first:3.64 18:32:35 INFO - PROCESS | 21221 | Values: 90.0 82.0 78.0 85.0 79.0 89.0 81.0 79.0 78.0 81.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:133.00 stddev:13.44 (10.1%) stddev-sans-first:14.18 18:32:35 INFO - PROCESS | 21221 | Values: 140.0 134.0 135.0 132.0 127.0 129.0 131.0 129.0 173.0 132.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:167.00 stddev:2.01 (1.2%) stddev-sans-first:1.72 18:32:35 INFO - PROCESS | 21221 | Values: 170.0 166.0 165.0 165.0 169.0 164.0 166.0 168.0 168.0 165.0 18:32:35 INFO - PROCESS | 21221 | 18:32:35 INFO - PROCESS | 21221 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 18:32:35 INFO - PROCESS | 21221 | Values: 67.0 68.0 69.0 68.0 66.0 67.0 66.0 67.0 67.0 66.0 18:32:35 INFO - PROCESS | 21221 | -------- Summary: end -------- 18:32:35 INFO - PROCESS | 21221 | 18:32:36 INFO - TEST-INFO | 21221: exit 0 18:32:36 INFO - TEST-OK | kraken | took 63164ms 18:32:36 INFO - SUITE-END | took 1182s 18:32:36 INFO - Completed test suite (00:19:42) 18:32:36 INFO - javascript benchmark 18:32:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.0250407349276, 2653.668291463567, 2674.531956907542, 2686.516427043133, 2689.69068557116, 4625.930611040829, 4675.0, 4766.285057241415, 4810.254410566364, 4818.927716084258, 4690.718556886581, 4710.199266124759, 4742.430908291001, 4747.026859493804, 4764.118638051954, 4234.237837189305, 4248.702590818644, 4295.484541854966, 4352.412424322708, 4415.183191109655, 4340.7395556266565, 4373.234683930315, 4402.515723270438, 4414.911701765963, 4418.028033832552, 4205.705600607958, 4247.723897946624, 4362.781860906974, 4371.9507318243395, 4473.2171869922795, 4260.9147817043795, 4298.226319262531, 4316.395704601358, 4318.287482565404, 4342.956570434287, 4274.935875961863, 4321.7406955582765, 4325.5025672047805, 4333.155034768221, 4371.038371558252, 4586.082783443325, 4702.623790096784, 4757.833475828329, 4800.3759511263315, 4808.543188397097, 5000.349954505928, 5039.269305950654, 5055.797768089272, 5122.3853137623355, 5124.923126153073, 5096.694198348074, 5110.897782044338, 5141.357330333708, 5148.974255128738, 5160.974195129001, 4680.602148817388, 4695.413073365863, 4740.26525888481, 4757.09615173116, 4759.881002974953, 5193.065248255275, 5223.190405487156, 5256.842294731164, 5271.683698978073, 5273.31446911899, 4974.27872958419, 4984.501549844987, 5039.496050395004, 5040.168372218616, 5085.618578606619, 4885.780139893714, 4997.9750101249265, 5088.414832294259, 5152.768125434364, 5158.871028224325, 5043.899122017539, 5108.080545501771, 5108.412532558729, 5152.175651895754, 5155.871103222449, 5061.670991385622, 5064.0, 5072.467390923974, 5078.97460512695, 5122.820701275437, 4197.706160568731, 4248.532661407243, 4328.7402755834755, 4343.109662519176, 4377.037051848588, 3708.49935258742, 3712.443133529938, 3734.626537346244, 3773.0, 3830.559485659129, 4353.499347575006, 4357.063231405263, 4359.17175736609, 4395.362672412482, 4398.296272596369, 4967.205247160509, 5094.796208151706, 5096.643234973591, 5096.9490305097215, 5140.820071297487, 4299.204647140226, 4304.0, 4322.37325587788, 4369.300911854088, 4420.84527041552, 4536.455625324982, 4569.451665800058, 4573.588377046081, 4576.336431217522, 4621.838235661803, 4812.975935120302, 4817.638677099161, 4819.95180048195, 4825.0349930013435, 4868.464468908346, 4916.680415772963, 5062.822801202087, 5093.694378337312, 5095.439501654889, 5160.406553246275, 4813.302071199586, 4833.516648335279, 4840.6127509798425, 4851.499925376903, 4880.194767863263, 4967.3542439482635, 5009.574186194214, 5020.0, 5021.171506701354, 5064.392272927125, 4931.50684931504, 5006.148954677641, 5064.4935506449065, 5083.669561478492, 5144.202648589475, 4895.975520122377, 4908.190148625579, 4915.4592994771265, 4918.704877707206, 4963.851084467472, 4902.117618828645, 4904.8773780655765, 4910.729909854992, 4913.140200464833, 4960.454350021422, 4706.199946009118, 4779.450363208275, 4825.203841366276, 4840.8789780254365, 4894.632902532396, 4989.950100498949, 4997.750112494434, 5011.173156429294, 5020.297158397754, 5059.038782631288, 4881.707097574157, 4897.2654101885, 4897.534734200245, 4904.558589726942, 4950.0], "value": 4658.112765697893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.108626198083, 573.1288441568815, 575.9164921086441, 581.7120525339957, 587.7795826565039, 27074.187774366776, 29711.40577188455, 40968.59031409689, 42213.0, 42352.0, 41223.58776412235, 41656.37515437263, 41660.0, 41700.16599668005, 41726.0, 7774.0671119465605, 7924.881126783102, 7926.762197134095, 7928.405369597274, 7934.404919631022, 7437.0, 9879.06148915852, 10057.044580764852, 10104.595816167344, 10462.947685261563, 10228.846567301496, 10321.793564128751, 10330.690079297634, 10334.276600637959, 10335.896641033569, 10185.439800810953, 10227.0, 10255.384676919408, 10258.9487052565, 10259.640912568098, 10062.79874402515, 10154.593816247341, 10156.746081347952, 10159.441230732307, 10163.644272450429, 38044.80977595122, 38131.42802857959, 38269.80865095657, 38272.0, 38336.42495362572, 3080.383923215366, 3086.151308390188, 3152.8423578820966, 3174.238182836126, 3387.44107222308, 29447.70552294471, 30073.248168795955, 30149.0, 30175.245618859484, 30226.093217203517, 3427.8971630851115, 3562.109472631842, 3649.489071529988, 3692.46459263408, 3698.33429982603, 252675.0, 254342.0, 254442.0, 254645.0, 254666.0, 55541.16688249679, 55610.72194639082, 55852.16221756677, 55863.0, 55983.44016559864, 57048.71475642678, 57061.0, 57225.14162287569, 57297.427025730045, 57375.71312143496, 15061.397544098114, 15304.846951530342, 15321.770173447407, 15331.156786376634, 15338.616534586501, 9441.386309889835, 9678.419294842332, 11725.472353744102, 11860.051195904307, 11860.584879529175, 16268.26792794327, 16427.0, 16677.416290429777, 17182.74225886613, 17320.0, 5796.82609521715, 5838.79564215259, 5918.201042859245, 6008.939910600925, 6021.789237376671, 825.6367198432671, 849.1169184048644, 884.1539304027557, 926.2312280806914, 1020.3163880200284, 27747.265103773356, 27881.72118278832, 27995.580066299022, 28338.858305708338, 28575.71424285772, 876.2726936642572, 919.595378033663, 943.5612440215333, 955.2978560757838, 968.7820240445843, 14669.633259168606, 14752.20668674771, 14818.33317500715, 14874.980092371405, 15075.321610527553, 373864.0, 377310.0, 377374.0, 377994.0, 653602.0, 50374.0, 51389.486105139214, 51392.0, 56714.432855670915, 56730.0, 1142.582957220625, 1153.901918336934, 1176.2942234659135, 1180.4982882275172, 1183.207251141737, 28211.294717632223, 29656.258593535335, 29699.406011880073, 30208.848955755082, 30255.546166807955, 44605.33092003558, 44991.77504112459, 45077.77461112673, 45084.32373514466, 45090.77454612706, 279915.0, 279921.0, 279973.0, 280178.0, 280514.0, 36762.63237367699, 37642.43536347012, 37757.244855102195, 38022.09889505569, 38154.42768358421, 41830.58169418267, 42242.0, 42621.14757704767, 43139.784301078296, 43377.0, 36131.45802812908, 36565.45151822778, 36647.08382290464, 37232.81383593065, 37299.62700372961, 36026.63973360233, 36133.81933090318, 36187.81906090558, 36882.26235475329, 36961.26077478489, 35243.47134793032, 35407.46888796722, 36149.09627259339, 36315.27369452544, 36559.45160822537, 31320.21699457532, 33194.66805332012, 33287.83356083204, 33765.493517597744, 33878.3224335507, 25298.620520691835, 25498.872505638094, 25660.743392565837, 25970.0, 26030.0], "value": 18315.245853138633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.96770306820844, 357.5173515753734, 359.94060979938314, 362.7623906341346, 389.48587864019487, 12823.935880320609, 15955.441559545417, 16221.594460138502, 17134.31462741489, 18108.094595270217, 17156.39952601659, 17202.913985430056, 17269.222884970175, 17422.128893555335, 17549.122543872818, 4884.5848102911295, 4915.483874193212, 5098.286239926413, 5138.434772175057, 5139.0, 3697.0757310672334, 5006.924896126561, 5119.974400127994, 5640.153976903477, 5955.285365756115, 5932.199153114318, 5982.700864956757, 5994.670293133898, 5994.940050599504, 5996.640201587918, 5209.479052094817, 5427.701476418795, 5447.591430642718, 5538.889222215533, 5974.193483879664, 5355.357357117132, 5358.91961620576, 5361.946380536223, 5365.7585408656705, 5366.4633536646415, 12175.939120304341, 12437.502499899992, 12460.501579936792, 12584.81122783159, 12769.042321825807, 1764.6558921010408, 1861.3764388929724, 1980.8910509921948, 2071.30611245233, 2257.796798288162, 9140.131687489678, 9603.903960960371, 9609.183219426357, 9735.318527703064, 12555.874441255562, 1701.6851882401672, 1720.4838548435544, 1738.5219064757293, 1768.6285879965224, 1849.9075046247633, 64765.35234647687, 65697.67151164214, 65973.34026659768, 69260.0, 69307.99999999949, 10079.596816127272, 10248.026437488426, 10251.179905607534, 10420.593219915214, 10505.636231847926, 11063.446827658585, 13932.024758266823, 13936.651583710285, 13944.651383715489, 13970.930145349208, 6919.100516932766, 6927.376536111774, 6998.860022799618, 7317.707291708379, 7326.487145899842, 6682.933170668328, 6962.477814163958, 7043.788686339418, 7392.55644661322, 7416.666250018762, 3697.4084146536425, 3818.198178382571, 3821.1975485147873, 3865.9613403866165, 3962.5641179470235, 1784.6787578235783, 1870.436135828574, 1876.55900863297, 1914.7989461106663, 1953.1113343428706, 767.861784878716, 844.2275318084007, 875.1336177184542, 877.3726785348506, 897.8731691726972, 16612.0, 16703.0, 16944.322227110777, 17340.0, 17915.37296194653, 829.2536716954669, 850.5704619167404, 861.3841103610948, 903.4850135422878, 905.9139381758722, 9488.525573721286, 9805.509724513746, 9971.601135954626, 10018.549165287579, 10179.338343007681, 409752.6098956008, 411206.0, 411864.0, 413111.0, 413507.0, 49317.50682493201, 62888.05667914893, 83219.16780832235, 85384.0, 85730.0, 897.1432282170512, 902.5397047505819, 902.7923577577194, 906.6101576322113, 909.5543183840003, 14937.103773773608, 15315.693686126438, 15332.0, 15474.5357639271, 16075.874688771673, 37666.811665942594, 39679.0, 39938.80030599829, 40053.59946400499, 40415.797921010206, 48765.5123448761, 49534.0, 51616.22575661293, 58903.705481472316, 59131.0, 7572.924270757442, 7743.690252389842, 7846.215378462108, 7923.564203968837, 8091.0, 9098.681546145854, 11648.941755291507, 11790.882091178979, 12375.69060773488, 12709.364531773559, 10188.643397481053, 10287.124360613596, 10367.185742494883, 10782.568697252336, 10928.945355273172, 10570.0, 10700.785984280115, 10874.135780071909, 10942.617008404668, 11011.394373309224, 9608.327417080738, 10167.79664406693, 10508.264421490423, 10632.25574209798, 10824.296420732628, 7550.509216900884, 7835.294823465915, 7974.322182614543, 8035.397345199251, 8065.395095367753, 10407.271490995861, 10859.619913302997, 10866.61966831157, 11035.724106897393, 11460.885391145981], "value": 8171.340094322905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.404708716273, 1288.6713887958572, 1349.1500354776492, 1365.3651052260702, 1658.6682663467302, 6308.810735677931, 7295.343419092287, 7501.43739219558, 7526.510776799504, 7756.728514501993, 7597.202293759158, 7641.503302285348, 7651.387888968883, 7655.387568994481, 7660.846783064336, 2162.145952348821, 2190.5290362572046, 2191.3097374327117, 2194.2868567715554, 2195.4401627584944, 2117.3224568138126, 2157.7518585362727, 2176.3688530326185, 2177.586258610867, 2180.8364372672036, 2118.7775283595233, 2135.4341099608614, 2142.9785702143013, 2143.4212762554102, 2162.805347518723, 2115.185653523397, 2116.2593092417683, 2117.280124757582, 2118.4174352053233, 2119.7244358233484, 2084.155916853677, 2138.6791981202787, 2139.304725964068, 2142.239504975727, 2142.6571748520164, 7150.0, 7530.096388433423, 7574.3183113520045, 7638.541687498712, 7639.9236007639765, 4466.0, 4641.651876109271, 4645.558671926162, 4656.650751193674, 4663.533646635343, 2787.3031742064486, 2952.1733914503975, 2968.2430980100153, 2989.282572182682, 3011.6988301169927, 887.9778005549848, 895.3016647015338, 899.4917871402637, 911.334725650279, 911.6490151291734, 10146.086852183265, 10236.129928956048, 10251.48742562869, 10259.743506412326, 10261.333013354182, 3773.509443772292, 3999.7400168988925, 4063.878083657495, 4098.364753463218, 4100.446439730598, 8222.671093156327, 8226.218509241613, 8226.506409615442, 8231.34149268057, 8239.340852731768, 4549.954500455019, 4553.977230113828, 4554.43069616298, 4564.42944631921, 4564.885877853014, 3607.458881167846, 3706.5737440194184, 4090.468239128954, 4242.766647834337, 4247.97876010618, 3415.26571787067, 3451.154467155563, 3549.4498352755363, 3560.412531932254, 3588.085038315213, 1059.142094903131, 1064.9254552181428, 1071.8499410082595, 1085.1969542538623, 1094.3871431998107, 757.5492581913752, 762.2567996203768, 802.9397795165386, 821.7904434369198, 844.8690452979798, 5415.512603865593, 5474.206240095164, 5485.61600687948, 5490.917636235459, 5521.0, 825.2984962781587, 841.2680967558264, 868.5309932636305, 872.3283072034498, 877.2937785082942, 3590.8204589770407, 3652.6164752701116, 3666.156783939709, 3736.9439458408146, 3802.9429558556644, 9158.542072896462, 9543.093406126407, 9557.808843823084, 9568.282378821616, 9586.328956972944, 9492.952535237418, 9522.428654280766, 9534.713958581253, 9539.904600953902, 9564.61741530331, 7099.467539934422, 7269.927300726925, 7273.0, 7291.598962057138, 7295.051643286339, 5136.409312928911, 5169.767360468863, 5187.170052791535, 5280.445553216857, 5531.419200984, 8428.747137585882, 8602.268807151462, 8747.868781968149, 8751.124887511198, 8806.0, 8553.74338769838, 8794.868076978722, 8843.513606751432, 8854.513001784964, 8854.734357969272, 5683.744231509675, 6388.93611063902, 6400.647964362005, 6674.733010679518, 6705.295943926013, 7087.858242835217, 7141.392981596622, 7327.2672732726305, 7329.560226386434, 7334.633268336455, 6314.273858506331, 6346.397092276226, 6423.42189202974, 6549.443297319781, 6626.27111017778, 6653.334666533308, 6654.467642588678, 6673.0, 6680.298568650416, 6692.899606505809, 6247.468965138014, 6352.555321127476, 6371.681415929278, 6382.90425643625, 6385.201849768779, 4441.0895766367175, 4522.0, 4727.314539391838, 4749.857504274877, 4778.331033655221, 4615.653825963133, 4643.373144625568, 4701.435827700698, 4743.45450273223, 4914.36113305268], "value": 4051.108622750192, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.12330849552677, 286.0973628203019, 292.4939854052488, 293.17325143096474, 295.7382716296078, 4878.170710979133, 4918.926216106761, 4919.901601967958, 4922.064807686537, 4952.554270115689, 4569.01247957138, 4691.577758001779, 4770.594499467549, 4793.568578827905, 4883.536064073907, 3784.110733977513, 3785.902088394362, 3806.9428958565645, 3818.770873747584, 3829.8468061277586, 3793.222389410178, 3811.6378944000276, 3812.8284227209842, 3821.675157611606, 3843.0584506795876, 3602.9823298952538, 3644.7266455015847, 3766.0, 3768.5666148392875, 3778.1310298631333, 3737.2338670572603, 3744.8314825832904, 3788.3181027415053, 3789.829457674411, 3799.6960243180615, 3328.400887840188, 3332.4001679697644, 3334.3498017886523, 3339.1819004344093, 3344.5317655528247, 4523.855920135507, 4761.904761904742, 4791.329213910055, 4793.0, 4812.663113582051, 4261.786910654455, 4297.828086876552, 4303.935440968388, 4305.3326734355915, 4306.7631280279575, 5121.769520371555, 5125.564327032207, 5130.230465430178, 5133.12736834739, 5161.7161056141895, 3564.055525285801, 3567.678908898212, 3571.482135090397, 3579.6062433132333, 3585.2470981094, 5225.686458812484, 5278.498542638443, 5303.7348132593215, 5320.228566857822, 5324.600654950856, 3625.546806649169, 3637.1452708613456, 3637.3270944875285, 3658.63413658632, 3672.247189326182, 3708.554973403209, 3718.6839118674675, 3719.6609220680534, 3720.720945929066, 3724.5902950675404, 4120.896977575585, 4240.494624408352, 4281.7645029523055, 4282.957170428318, 4288.292431748727, 5047.369078865142, 5048.697078175322, 5059.165237735732, 5061.417936937226, 5068.935523540098, 1220.992681038147, 1250.1498980693034, 1251.205484517338, 1258.4148371007525, 1265.6013355792895, 808.6603626476893, 808.9474184178009, 852.5907564369138, 868.0538213347481, 875.6847534887436, 4430.645548356124, 4432.15789000089, 4441.0, 4443.488998765119, 4445.488768791565, 5160.380754309507, 5164.406093299319, 5172.663776854492, 5181.922271165936, 5184.5593124584075, 4243.427137336482, 4448.177087238806, 4469.374287599739, 4471.329300604935, 4479.776011199492, 2732.5081485332435, 2740.7122252163235, 2744.0807329544828, 2746.9038583649476, 2781.9860900695367, 4841.031793641286, 4854.296127061556, 4864.756762161877, 4883.121038213085, 4897.2654101885, 5084.56781173597, 5251.238570407269, 5254.029738847932, 5258.553022993012, 5271.970291437824, 4876.853694389174, 4882.145624515767, 4906.2640603909695, 4907.55831975124, 4908.950910490992, 5181.896362072813, 5185.688858668492, 5194.337811900306, 5197.0, 5200.947990520046, 4909.7545122743, 5079.5428411443145, 5101.413337466239, 5142.5885929126325, 5153.561947234527, 4950.455449900436, 4964.503549645006, 4973.825916092919, 4989.301497790385, 4993.850184494471, 3683.576388715332, 3750.7374483785875, 3762.097096696828, 3769.3215221260434, 3771.283456143324, 5118.539331460186, 5296.973515132554, 5325.201219816903, 5334.226537152169, 5344.305240318734, 5080.923786143285, 5103.617228707936, 5106.131957567297, 5111.667741596784, 5112.769925353442, 5063.215201643751, 5078.695278283315, 5100.26046223303, 5105.2342148678, 5115.0, 4843.0, 4933.975330123327, 4946.332245146859, 4976.412265621929, 5000.14997450427, 4908.141075311878, 5082.593392528663, 5107.693538387709, 5109.335786347751, 5134.460881607527, 4893.290472881341, 4946.653734238569, 4984.950150498448, 5060.089183946925, 5064.848054558369], "value": 3809.1409245399245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.2145211225409, 611.1352436302632, 616.0337972661633, 686.6841253023612, 735.6358602491767, 12746.362681865905, 13754.174749515036, 13754.381052852621, 13758.724825503485, 13759.65600859979, 11470.7132321692, 11504.597339093134, 11541.134414918894, 11587.130965177603, 13150.0, 776.1578687124477, 794.5351969098084, 799.1089934722771, 799.4963173200875, 799.9400044996648, 792.6512334572799, 796.108358638323, 796.5380079553845, 796.5499492786586, 796.9163237860029, 836.0469065265602, 837.476577139288, 837.7277384849948, 837.9162083791603, 837.9832403351929, 828.867381219008, 829.5727700234354, 831.0692024932084, 831.6008316008289, 832.0306842528447, 606.4511616986634, 606.4632799972056, 606.7845914700306, 606.7967230977583, 606.8240210338996, 12495.875041249654, 12498.875011249862, 12524.185927914656, 12525.812112818316, 12535.561255356019, 12782.488700451971, 12929.353532323346, 13065.673358166026, 13205.33973301331, 13370.866291337157, 9797.167240784542, 9804.607815687365, 9850.594835475275, 9951.232109335377, 9975.251856110748, 3314.7016768490953, 3324.4847048707247, 3351.5307856900054, 3360.9663903360897, 3374.645662205482, 41676.79161604172, 53417.1987420189, 59576.40423595752, 61301.6934915327, 62849.371506285264, 10378.325408848401, 10433.530491127918, 10466.476676166314, 10550.788984220273, 10688.14494840411, 18893.055347232585, 18928.526786830163, 18937.14782834776, 18947.905260473886, 18948.526286842938, 6980.755673551402, 6985.26654701249, 7038.577685338896, 7155.427565794724, 7210.67551960163, 3749.9062523437133, 3836.635519625631, 3877.9612203878164, 3949.9927518482605, 3983.6215559521797, 2899.1882272963603, 3013.0659495556447, 3022.335086281015, 3023.3046399328277, 3024.1834704629628, 489.5104895104895, 504.85611600693625, 510.1276816643581, 511.98976020480126, 542.6310109125832, 537.9462053794589, 566.2553741829481, 575.9913601295984, 581.5580159079046, 596.4155127974609, 8042.718504852302, 8120.14738452454, 8394.202550757669, 8449.788755281168, 8613.913860861312, 443.99778001109786, 471.4554689333825, 475.7070918174366, 570.6091327440716, 590.8641012567134, 3778.414345776354, 3931.312020396419, 3947.2302900934615, 3952.2885880541203, 4165.479315085614, 55724.0, 58697.0, 96361.51819240859, 96915.51542242385, 96990.51504742431, 77785.2221477778, 78197.21802781899, 79150.6042469784, 79857.0, 81395.0, 41782.582174178475, 42974.57025429768, 68764.6561767188, 70231.29768702248, 72963.0, 8250.46371985819, 8400.789980250544, 8457.915420845713, 8798.604062817316, 8841.0, 29622.259443514085, 38518.037049072875, 38865.805670971466, 39394.6060539391, 43526.0, 40737.59262407457, 41298.79350603348, 45392.0, 59729.0, 60491.39508604858, 10621.787564248827, 10664.946675266885, 10835.51240194209, 10912.290701104403, 11412.71468213268, 12237.938810306248, 12348.876511234772, 12617.81073283883, 13210.405531750903, 13247.470101195844, 10743.409112498888, 11224.607138750105, 11297.43512824372, 11299.774004520028, 11357.943210283896, 10728.034476897117, 10917.727056823644, 11002.50488728025, 11657.825132622847, 11664.94167529157, 10361.896381036093, 10660.360378377321, 10808.621698240524, 11049.834252486058, 11201.719957000814, 9485.193758530602, 9929.31119513391, 10239.612490818577, 10337.328073675188, 10423.270371073952, 9131.589078491352, 9768.36505627132, 9893.109620134222, 9989.900100999188, 10068.0], "value": 6345.369710131506, "unit": "score"}], "name": "dromaeo_css", "value": 6392.994632465389, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 115.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 129.0, 175.0, 124.0, 123.0, 143.0, 123.0, 173.0, 122.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 164.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 125.0, 75.0, 82.0, 75.0, 76.0, 106.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 119.0, 86.0, 85.0, 86.0, 135.0, 85.0, 85.0, 124.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 61.0, 60.0, 62.0, 62.0, 61.0, 62.0, 60.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 78.0, 85.0, 79.0, 89.0, 81.0, 79.0, 78.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 135.0, 132.0, 127.0, 129.0, 131.0, 129.0, 173.0, 132.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 165.0, 165.0, 169.0, 164.0, 166.0, 168.0, 168.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1532.4999999999998, "alertThreshold": 2.0}]} 18:32:36 INFO - Return code: 0 18:32:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:36 INFO - # TBPL SUCCESS # 18:32:36 INFO - Running post-action listener: _resource_record_post_action 18:32:36 INFO - [mozharness: 2016-07-31 01:32:36.750015Z] Finished run-tests step (success) 18:32:36 INFO - Running post-run listener: _resource_record_post_run 18:32:36 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521613312; Read time: 12; Write time: 405256 18:32:36 INFO - TinderboxPrint: CPU usage
13.0% 18:32:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:32:36 INFO - TinderboxPrint: I/O write bytes / time
521,613,312 / 405,256 18:32:36 INFO - TinderboxPrint: CPU idle
8,329.2 (87.0%) 18:32:36 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 18:32:36 INFO - TinderboxPrint: Swap in / out
0 / 0 18:32:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237297664; Read time: 0; Write time: 227232 18:32:36 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 284315648; Read time: 0; Write time: 178024 18:32:37 INFO - Running post-run listener: _upload_blobber_files 18:32:37 INFO - Blob upload gear active. 18:32:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:32:37 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:32:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:32:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:38 INFO - (blobuploader) - INFO - Done attempting. 18:32:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:41 INFO - (blobuploader) - INFO - Done attempting. 18:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:42 INFO - (blobuploader) - INFO - Done attempting. 18:32:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:42 INFO - Return code: 0 18:32:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/93b0452268e8591eb09c64aad27d8701c96d23e1aa66fce0f7a37c63fc54429e509a3385c797083b8de9cf159e0282c55e92463e4210c8f5fe7f7e47b44eb807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ec7a93c39dc01891f2e9ae2b89e1e9ebddb689ae57a7c35322d825e9dc68952c42832a0e54561ccbee51be527458ffc368e6378e517da63ef993a8d7bc05a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a00a213cd6fd9213fb22b6fb130507143d19d61169ecd66594d84a1a36562d450bbffcebb59c2f98794cc0a69fea71116e6fde5b14a3735c439c1087a7e6f8eb"} 18:32:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:42 INFO - Contents: 18:32:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/93b0452268e8591eb09c64aad27d8701c96d23e1aa66fce0f7a37c63fc54429e509a3385c797083b8de9cf159e0282c55e92463e4210c8f5fe7f7e47b44eb807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ec7a93c39dc01891f2e9ae2b89e1e9ebddb689ae57a7c35322d825e9dc68952c42832a0e54561ccbee51be527458ffc368e6378e517da63ef993a8d7bc05a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a00a213cd6fd9213fb22b6fb130507143d19d61169ecd66594d84a1a36562d450bbffcebb59c2f98794cc0a69fea71116e6fde5b14a3735c439c1087a7e6f8eb"} 18:32:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:42 INFO - Copying logs to upload dir... 18:32:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.494408 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-30 18:32:42.284275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 18:32:42.287752) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859 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/93b0452268e8591eb09c64aad27d8701c96d23e1aa66fce0f7a37c63fc54429e509a3385c797083b8de9cf159e0282c55e92463e4210c8f5fe7f7e47b44eb807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ec7a93c39dc01891f2e9ae2b89e1e9ebddb689ae57a7c35322d825e9dc68952c42832a0e54561ccbee51be527458ffc368e6378e517da63ef993a8d7bc05a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a00a213cd6fd9213fb22b6fb130507143d19d61169ecd66594d84a1a36562d450bbffcebb59c2f98794cc0a69fea71116e6fde5b14a3735c439c1087a7e6f8eb"} build_url:https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/UBKSf6sbRo-2VQKQ2U5Zpg/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/93b0452268e8591eb09c64aad27d8701c96d23e1aa66fce0f7a37c63fc54429e509a3385c797083b8de9cf159e0282c55e92463e4210c8f5fe7f7e47b44eb807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ec7a93c39dc01891f2e9ae2b89e1e9ebddb689ae57a7c35322d825e9dc68952c42832a0e54561ccbee51be527458ffc368e6378e517da63ef993a8d7bc05a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a00a213cd6fd9213fb22b6fb130507143d19d61169ecd66594d84a1a36562d450bbffcebb59c2f98794cc0a69fea71116e6fde5b14a3735c439c1087a7e6f8eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 18:32:42.312364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:32:42.312670) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469924888.894324-780840859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 18:32:42.398146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 18:32:42.398464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 18:32:42.398745) ========= ========= Total master_lag: 0.25 =========