builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1469541467.04 results: success (0) buildid: 20160726053703 builduid: 4d841ad3cbcf430e8b6da9a78ac90e33 revision: 54c8557ec453a787f045d79164bead2e5f95cee7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.041347) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.041855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.042150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.056950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.057358) ========= 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=1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 06:57:47-- 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% 66.8M=0s 2016-07-26 06:57:47 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.204651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.204987) ========= 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=1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018165 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.254638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:47.255015) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 54c8557ec453a787f045d79164bead2e5f95cee7 --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 54c8557ec453a787f045d79164bead2e5f95cee7 --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=1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 06:57:47,550 truncating revision to first 12 chars 2016-07-26 06:57:47,550 Setting DEBUG logging. 2016-07-26 06:57:47,550 attempt 1/10 2016-07-26 06:57:47,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/54c8557ec453?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 06:57:48,097 unpacking tar archive at: autoland-54c8557ec453/testing/mozharness/ program finished with exit code 0 elapsedTime=0.869124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:48.139511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:48.139861) ========= script_repo_revision: 54c8557ec453a787f045d79164bead2e5f95cee7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:48.140262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:48.140572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 06:57:48.150308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-26 06:57:48.150629) ========= /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=1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:48 INFO - MultiFileLogger online at 20160726 06:57:48 in /builds/slave/test 06:57:48 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 06:57:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:48 INFO - {'append_to_log': False, 06:57:48 INFO - 'base_work_dir': '/builds/slave/test', 06:57:48 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 06:57:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:48 INFO - 'branch': 'Autoland-Non-PGO', 06:57:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:48 INFO - 'config_files': ('talos/linux_config.py',), 06:57:48 INFO - 'default_actions': ('clobber', 06:57:48 INFO - 'read-buildbot-config', 06:57:48 INFO - 'download-and-extract', 06:57:48 INFO - 'populate-webroot', 06:57:48 INFO - 'create-virtualenv', 06:57:48 INFO - 'install', 06:57:48 INFO - 'run-tests'), 06:57:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:48 INFO - 'download_minidump_stackwalk': True, 06:57:48 INFO - 'download_symbols': 'ondemand', 06:57:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:48 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:48 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:48 INFO - 'installer_path': 'installer.exe', 06:57:48 INFO - 'log_level': 'info', 06:57:48 INFO - 'log_name': 'talos', 06:57:48 INFO - 'log_to_console': True, 06:57:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:48 INFO - 'opt_config_files': (), 06:57:48 INFO - 'pip_index': False, 06:57:48 INFO - 'sps_profile': False, 06:57:48 INFO - 'sps_profile_interval': 0, 06:57:48 INFO - 'suite': 'dromaeojs', 06:57:48 INFO - 'system_bits': '32', 06:57:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:48 INFO - 'title': 'talos-linux64-ix-027', 06:57:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:48 INFO - 'use_talos_json': True, 06:57:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:48 INFO - 'work_dir': 'build'} 06:57:48 INFO - [mozharness: 2016-07-26 13:57:48.537933Z] Running clobber step. 06:57:48 INFO - Running pre-action listener: _resource_record_pre_action 06:57:48 INFO - Running main action method: clobber 06:57:48 INFO - rmtree: /builds/slave/test/build 06:57:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:49 INFO - Running post-action listener: _resource_record_post_action 06:57:49 INFO - [mozharness: 2016-07-26 13:57:49.537253Z] Finished clobber step (success) 06:57:49 INFO - [mozharness: 2016-07-26 13:57:49.537373Z] Running read-buildbot-config step. 06:57:49 INFO - Running pre-action listener: _resource_record_pre_action 06:57:49 INFO - Running main action method: read_buildbot_config 06:57:49 INFO - Using buildbot properties: 06:57:49 INFO - { 06:57:49 INFO - "project": "", 06:57:49 INFO - "product": "firefox", 06:57:49 INFO - "script_repo_revision": "production", 06:57:49 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 06:57:49 INFO - "repository": "", 06:57:49 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 06:57:49 INFO - "buildid": "20160726053703", 06:57:49 INFO - "pgo_build": "False", 06:57:49 INFO - "basedir": "/builds/slave/test", 06:57:49 INFO - "buildnumber": 113, 06:57:49 INFO - "slavename": "talos-linux64-ix-027", 06:57:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:57:49 INFO - "platform": "ubuntu64_hw", 06:57:49 INFO - "scheduler": "tests-autoland-linux64-talos", 06:57:49 INFO - "branch": "autoland", 06:57:49 INFO - "repo_path": "integration/autoland", 06:57:49 INFO - "revision": "54c8557ec453a787f045d79164bead2e5f95cee7", 06:57:49 INFO - "stage_platform": "linux64", 06:57:49 INFO - "builduid": "4d841ad3cbcf430e8b6da9a78ac90e33", 06:57:49 INFO - "slavebuilddir": "test" 06:57:49 INFO - } 06:57:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:57:49 INFO - Running post-action listener: _resource_record_post_action 06:57:49 INFO - [mozharness: 2016-07-26 13:57:49.539824Z] Finished read-buildbot-config step (success) 06:57:49 INFO - [mozharness: 2016-07-26 13:57:49.539913Z] Running download-and-extract step. 06:57:49 INFO - Running pre-action listener: _resource_record_pre_action 06:57:49 INFO - Running main action method: download_and_extract 06:57:49 INFO - mkdir: /builds/slave/test/build/tests 06:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:49 INFO - https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:57:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:57:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:57:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:50 INFO - Downloaded 1361 bytes. 06:57:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:57:50 INFO - Using the following test package requirements: 06:57:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:57:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'jsshell-linux-x86_64.zip'], 06:57:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:57:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:57:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:50 INFO - https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:51 INFO - Downloaded 22742267 bytes. 06:57:51 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'] 06:57:51 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 06:57:52 INFO - Return code: 0 06:57:52 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 06:57:52 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')]} 06:57:52 INFO - https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:53 INFO - Downloaded 22742267 bytes. 06:57:53 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'] 06:57:53 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 06:57:54 INFO - Return code: 0 06:57:54 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')]} 06:57:54 INFO - https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:57:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:56 INFO - Downloaded 14413725 bytes. 06:57:56 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'] 06:57:56 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 06:57:56 INFO - Return code: 0 06:57:56 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')]} 06:57:56 INFO - https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FKOE3rd7R5mhi9qkN38-7w/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 06:57:58 INFO - Downloaded 57171026 bytes. 06:57:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:58 INFO - mkdir: /builds/slave/test/properties 06:57:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:57:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:57:58 INFO - Contents: 06:57:58 INFO - build_url:https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:58 INFO - Running post-action listener: _resource_record_post_action 06:57:58 INFO - Running post-action listener: set_extra_try_arguments 06:57:58 INFO - [mozharness: 2016-07-26 13:57:58.871067Z] Finished download-and-extract step (success) 06:57:58 INFO - [mozharness: 2016-07-26 13:57:58.871301Z] Running populate-webroot step. 06:57:58 INFO - Running pre-action listener: _resource_record_pre_action 06:57:58 INFO - Running main action method: populate_webroot 06:57:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:58 INFO - '--tppagecycles', 06:57:58 INFO - '7'], 06:57:58 INFO - 'tests': ['tsvgm']}}, 06:57:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:57:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:57:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:57:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['damp', 'tps']}, 06:57:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'tests': ['damp', 'tps']}, 06:57:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['dromaeo_dom']}, 06:57:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['basic_compositor_video']}, 06:57:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:57:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['a11yr', 06:57:58 INFO - 'ts_paint', 06:57:58 INFO - 'tpaint', 06:57:58 INFO - 'sessionrestore', 06:57:58 INFO - 'sessionrestore_no_auto_restore', 06:57:58 INFO - 'tabpaint']}, 06:57:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:57:58 INFO - 'ts_paint', 06:57:58 INFO - 'tpaint', 06:57:58 INFO - 'sessionrestore', 06:57:58 INFO - 'sessionrestore_no_auto_restore', 06:57:58 INFO - 'tabpaint']}, 06:57:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:57:58 INFO - 'ts_paint', 06:57:58 INFO - 'tpaint', 06:57:58 INFO - 'sessionrestore', 06:57:58 INFO - 'sessionrestore_no_auto_restore', 06:57:58 INFO - 'tabpaint']}, 06:57:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:57:58 INFO - 'ts_paint', 06:57:58 INFO - 'tpaint', 06:57:58 INFO - 'sessionrestore', 06:57:58 INFO - 'sessionrestore_no_auto_restore', 06:57:58 INFO - 'tabpaint']}, 06:57:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['a11yr', 06:57:58 INFO - 'ts_paint', 06:57:58 INFO - 'tpaint', 06:57:58 INFO - 'sessionrestore', 06:57:58 INFO - 'sessionrestore_no_auto_restore', 06:57:58 INFO - 'tabpaint']}, 06:57:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['a11yr', 06:57:58 INFO - 'ts_paint', 06:57:58 INFO - 'tpaint', 06:57:58 INFO - 'sessionrestore', 06:57:58 INFO - 'sessionrestore_no_auto_restore', 06:57:58 INFO - 'tabpaint']}, 06:57:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['tsvgx', 06:57:58 INFO - 'tsvgr_opacity', 06:57:58 INFO - 'tart', 06:57:58 INFO - 'tscrollx', 06:57:58 INFO - 'cart']}, 06:57:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:57:58 INFO - 'tsvgr_opacity', 06:57:58 INFO - 'tart', 06:57:58 INFO - 'tscrollx', 06:57:58 INFO - 'cart']}, 06:57:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'talos_options': ['--disable-e10s'], 06:57:58 INFO - 'tests': ['tp5o']}, 06:57:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'tests': ['tp5o']}, 06:57:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'talos_options': ['--disable-e10s', 06:57:58 INFO - '--xperf_path', 06:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:58 INFO - 'tests': ['tp5n']}, 06:57:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:58 INFO - 'talos_options': ['--xperf_path', 06:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:58 INFO - 'tests': ['tp5n']}}, 06:57:58 INFO - 'talos.zip': {'path': '', 06:57:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:58 INFO - Running post-action listener: _resource_record_post_action 06:57:58 INFO - [mozharness: 2016-07-26 13:57:58.888478Z] Finished populate-webroot step (success) 06:57:58 INFO - [mozharness: 2016-07-26 13:57:58.888567Z] Running create-virtualenv step. 06:57:58 INFO - Running pre-action listener: _resource_record_pre_action 06:57:58 INFO - Running main action method: create_virtualenv 06:57:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:57:58 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 06:57:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:57:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:58 INFO - Using real prefix '/usr' 06:57:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:57:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:01 INFO - Installing pip.................done. 06:58:01 INFO - Return code: 0 06:58:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:01 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 06:58:01 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 06:58:01 INFO - Using env: {'DISPLAY': ':0', 06:58:01 INFO - 'HOME': '/home/cltbld', 06:58:01 INFO - 'LANG': 'en_US.UTF-8', 06:58:01 INFO - 'LANGUAGE': 'en_US:en', 06:58:01 INFO - 'LOGNAME': 'cltbld', 06:58:01 INFO - 'MAIL': '/var/mail/cltbld', 06:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:01 INFO - 'MOZ_NO_REMOTE': '1', 06:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:01 INFO - 'NO_EM_RESTART': '1', 06:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:01 INFO - 'PWD': '/builds/slave/test', 06:58:01 INFO - 'SHELL': '/bin/bash', 06:58:01 INFO - 'SHLVL': '1', 06:58:01 INFO - 'TERM': 'linux', 06:58:01 INFO - 'TMOUT': '86400', 06:58:01 INFO - 'USER': 'cltbld', 06:58:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:01 INFO - '_': '/tools/buildbot/bin/python'} 06:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:01 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 06:58:01 INFO - Cleaning up... 06:58:01 INFO - Return code: 0 06:58:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:01 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 06:58:01 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 06:58:01 INFO - Using env: {'DISPLAY': ':0', 06:58:01 INFO - 'HOME': '/home/cltbld', 06:58:01 INFO - 'LANG': 'en_US.UTF-8', 06:58:01 INFO - 'LANGUAGE': 'en_US:en', 06:58:01 INFO - 'LOGNAME': 'cltbld', 06:58:01 INFO - 'MAIL': '/var/mail/cltbld', 06:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:01 INFO - 'MOZ_NO_REMOTE': '1', 06:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:01 INFO - 'NO_EM_RESTART': '1', 06:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:01 INFO - 'PWD': '/builds/slave/test', 06:58:01 INFO - 'SHELL': '/bin/bash', 06:58:01 INFO - 'SHLVL': '1', 06:58:01 INFO - 'TERM': 'linux', 06:58:01 INFO - 'TMOUT': '86400', 06:58:01 INFO - 'USER': 'cltbld', 06:58:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:01 INFO - '_': '/tools/buildbot/bin/python'} 06:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:01 INFO - Downloading/unpacking psutil>=3.1.1 06:58:01 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 06:58:01 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 06:58:01 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 06:58:01 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 06:58:01 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 06:58:01 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 06:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:03 INFO - Installing collected packages: psutil 06:58:03 INFO - Running setup.py install for psutil 06:58:03 INFO - building 'psutil._psutil_linux' extension 06:58:03 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 06:58:04 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 06:58:04 INFO - building 'psutil._psutil_posix' extension 06:58:04 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 06:58:04 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 06:58:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:04 INFO - Successfully installed psutil 06:58:04 INFO - Cleaning up... 06:58:04 INFO - Return code: 0 06:58:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:04 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:04 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 06:58:04 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 06:58:04 INFO - Using env: {'DISPLAY': ':0', 06:58:04 INFO - 'HOME': '/home/cltbld', 06:58:04 INFO - 'LANG': 'en_US.UTF-8', 06:58:04 INFO - 'LANGUAGE': 'en_US:en', 06:58:04 INFO - 'LOGNAME': 'cltbld', 06:58:04 INFO - 'MAIL': '/var/mail/cltbld', 06:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:04 INFO - 'MOZ_NO_REMOTE': '1', 06:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:04 INFO - 'NO_EM_RESTART': '1', 06:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:04 INFO - 'PWD': '/builds/slave/test', 06:58:04 INFO - 'SHELL': '/bin/bash', 06:58:04 INFO - 'SHLVL': '1', 06:58:04 INFO - 'TERM': 'linux', 06:58:04 INFO - 'TMOUT': '86400', 06:58:04 INFO - 'USER': 'cltbld', 06:58:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:04 INFO - '_': '/tools/buildbot/bin/python'} 06:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:58:04 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 06:58:04 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 06:58:04 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 06:58:04 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 06:58:04 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 06:58:04 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 06:58:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:58:06 INFO - Installing collected packages: mozsystemmonitor 06:58:06 INFO - Running setup.py install for mozsystemmonitor 06:58:06 INFO - Successfully installed mozsystemmonitor 06:58:06 INFO - Cleaning up... 06:58:06 INFO - Return code: 0 06:58:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:58:06 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')]} 06:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:06 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')]} 06:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:06 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:06 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 06:58:06 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 06:58:06 INFO - Using env: {'DISPLAY': ':0', 06:58:06 INFO - 'HOME': '/home/cltbld', 06:58:06 INFO - 'LANG': 'en_US.UTF-8', 06:58:06 INFO - 'LANGUAGE': 'en_US:en', 06:58:06 INFO - 'LOGNAME': 'cltbld', 06:58:06 INFO - 'MAIL': '/var/mail/cltbld', 06:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:06 INFO - 'MOZ_NO_REMOTE': '1', 06:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:06 INFO - 'NO_EM_RESTART': '1', 06:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:06 INFO - 'PWD': '/builds/slave/test', 06:58:06 INFO - 'SHELL': '/bin/bash', 06:58:06 INFO - 'SHLVL': '1', 06:58:06 INFO - 'TERM': 'linux', 06:58:06 INFO - 'TMOUT': '86400', 06:58:06 INFO - 'USER': 'cltbld', 06:58:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:06 INFO - '_': '/tools/buildbot/bin/python'} 06:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:06 INFO - Downloading/unpacking jsonschema==2.5.1 06:58:06 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 06:58:06 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 06:58:06 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 06:58:06 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 06:58:06 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 06:58:06 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 06:58:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:58:08 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 06:58:08 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 06:58:08 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 06:58:08 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 06:58:08 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 06:58:08 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 06:58:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:09 INFO - warning: no files found matching '*.txt' 06:58:09 INFO - no previously-included directories found matching 'build' 06:58:09 INFO - no previously-included directories found matching 'dist' 06:58:09 INFO - no previously-included directories found matching '.git*' 06:58:09 INFO - Installing collected packages: jsonschema, functools32 06:58:09 INFO - Running setup.py install for functools32 06:58:09 INFO - warning: no files found matching '*.txt' 06:58:09 INFO - no previously-included directories found matching 'build' 06:58:09 INFO - no previously-included directories found matching 'dist' 06:58:09 INFO - no previously-included directories found matching '.git*' 06:58:09 INFO - Successfully installed jsonschema functools32 06:58:09 INFO - Cleaning up... 06:58:09 INFO - Return code: 0 06:58:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:09 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:09 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 06:58:09 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 06:58:09 INFO - Using env: {'DISPLAY': ':0', 06:58:09 INFO - 'HOME': '/home/cltbld', 06:58:09 INFO - 'LANG': 'en_US.UTF-8', 06:58:09 INFO - 'LANGUAGE': 'en_US:en', 06:58:09 INFO - 'LOGNAME': 'cltbld', 06:58:09 INFO - 'MAIL': '/var/mail/cltbld', 06:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:09 INFO - 'MOZ_NO_REMOTE': '1', 06:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:09 INFO - 'NO_EM_RESTART': '1', 06:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:09 INFO - 'PWD': '/builds/slave/test', 06:58:09 INFO - 'SHELL': '/bin/bash', 06:58:09 INFO - 'SHLVL': '1', 06:58:09 INFO - 'TERM': 'linux', 06:58:09 INFO - 'TMOUT': '86400', 06:58:09 INFO - 'USER': 'cltbld', 06:58:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:09 INFO - '_': '/tools/buildbot/bin/python'} 06:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:58:09 INFO - Cleaning up... 06:58:09 INFO - Return code: 0 06:58:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:09 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:09 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 06:58:09 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 06:58:09 INFO - Using env: {'DISPLAY': ':0', 06:58:09 INFO - 'HOME': '/home/cltbld', 06:58:09 INFO - 'LANG': 'en_US.UTF-8', 06:58:09 INFO - 'LANGUAGE': 'en_US:en', 06:58:09 INFO - 'LOGNAME': 'cltbld', 06:58:09 INFO - 'MAIL': '/var/mail/cltbld', 06:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:09 INFO - 'MOZ_NO_REMOTE': '1', 06:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:09 INFO - 'NO_EM_RESTART': '1', 06:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:09 INFO - 'PWD': '/builds/slave/test', 06:58:09 INFO - 'SHELL': '/bin/bash', 06:58:09 INFO - 'SHLVL': '1', 06:58:09 INFO - 'TERM': 'linux', 06:58:09 INFO - 'TMOUT': '86400', 06:58:09 INFO - 'USER': 'cltbld', 06:58:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:09 INFO - '_': '/tools/buildbot/bin/python'} 06:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:09 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:09 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 06:58:09 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 06:58:09 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 06:58:09 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 06:58:09 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 06:58:09 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 06:58:11 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:11 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 06:58:11 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 06:58:11 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 06:58:11 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 06:58:11 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 06:58:11 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 06:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:12 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 06:58:12 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 06:58:12 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 06:58:12 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 06:58:12 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 06:58:12 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 06:58:12 INFO - Downloading docopt-0.6.1.tar.gz 06:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:12 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:12 INFO - Running setup.py install for blobuploader 06:58:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:12 INFO - Running setup.py install for requests 06:58:12 INFO - Running setup.py install for docopt 06:58:13 INFO - Successfully installed blobuploader requests docopt 06:58:13 INFO - Cleaning up... 06:58:13 INFO - Return code: 0 06:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:13 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:13 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 06:58:13 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 06:58:13 INFO - Using env: {'DISPLAY': ':0', 06:58:13 INFO - 'HOME': '/home/cltbld', 06:58:13 INFO - 'LANG': 'en_US.UTF-8', 06:58:13 INFO - 'LANGUAGE': 'en_US:en', 06:58:13 INFO - 'LOGNAME': 'cltbld', 06:58:13 INFO - 'MAIL': '/var/mail/cltbld', 06:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:13 INFO - 'MOZ_NO_REMOTE': '1', 06:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:13 INFO - 'NO_EM_RESTART': '1', 06:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:13 INFO - 'PWD': '/builds/slave/test', 06:58:13 INFO - 'SHELL': '/bin/bash', 06:58:13 INFO - 'SHLVL': '1', 06:58:13 INFO - 'TERM': 'linux', 06:58:13 INFO - 'TMOUT': '86400', 06:58:13 INFO - 'USER': 'cltbld', 06:58:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:13 INFO - '_': '/tools/buildbot/bin/python'} 06:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:13 INFO - Running setup.py (path:/tmp/pip-aWzD19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:13 INFO - Running setup.py (path:/tmp/pip-SfYH8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:13 INFO - Running setup.py (path:/tmp/pip-tpU3cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:13 INFO - Running setup.py (path:/tmp/pip-JC1vs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:13 INFO - Running setup.py (path:/tmp/pip-9R9I7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:13 INFO - Running setup.py (path:/tmp/pip-PPUfNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:13 INFO - Running setup.py (path:/tmp/pip-XFGNeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:13 INFO - Running setup.py (path:/tmp/pip-DlPq0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:13 INFO - Running setup.py (path:/tmp/pip-WARhtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:13 INFO - Running setup.py (path:/tmp/pip-6ZRcDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:13 INFO - Running setup.py (path:/tmp/pip-0v0cd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:14 INFO - Running setup.py (path:/tmp/pip-4jFEZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:14 INFO - Running setup.py (path:/tmp/pip-3NZonP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:14 INFO - Running setup.py (path:/tmp/pip-wCJ6fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:14 INFO - Running setup.py (path:/tmp/pip-4mnOsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:14 INFO - Running setup.py (path:/tmp/pip-K7DNcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:14 INFO - Running setup.py (path:/tmp/pip-oGlH6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:14 INFO - Running setup.py install for manifestparser 06:58:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:14 INFO - Running setup.py install for mozcrash 06:58:14 INFO - Running setup.py install for mozdebug 06:58:14 INFO - Running setup.py install for mozdevice 06:58:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:58:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:14 INFO - Running setup.py install for mozfile 06:58:15 INFO - Running setup.py install for mozhttpd 06:58:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Running setup.py install for mozinfo 06:58:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Running setup.py install for mozInstall 06:58:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Running setup.py install for mozleak 06:58:15 INFO - Running setup.py install for mozlog 06:58:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Running setup.py install for moznetwork 06:58:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Running setup.py install for mozprocess 06:58:15 INFO - Running setup.py install for mozprofile 06:58:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:15 INFO - Running setup.py install for mozrunner 06:58:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:16 INFO - Running setup.py install for mozscreenshot 06:58:16 INFO - Running setup.py install for moztest 06:58:16 INFO - Running setup.py install for mozversion 06:58:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:16 INFO - Cleaning up... 06:58:16 INFO - Return code: 0 06:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:16 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 06:58:16 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 06:58:16 INFO - Using env: {'DISPLAY': ':0', 06:58:16 INFO - 'HOME': '/home/cltbld', 06:58:16 INFO - 'LANG': 'en_US.UTF-8', 06:58:16 INFO - 'LANGUAGE': 'en_US:en', 06:58:16 INFO - 'LOGNAME': 'cltbld', 06:58:16 INFO - 'MAIL': '/var/mail/cltbld', 06:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:16 INFO - 'MOZ_NO_REMOTE': '1', 06:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:16 INFO - 'NO_EM_RESTART': '1', 06:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:16 INFO - 'PWD': '/builds/slave/test', 06:58:16 INFO - 'SHELL': '/bin/bash', 06:58:16 INFO - 'SHLVL': '1', 06:58:16 INFO - 'TERM': 'linux', 06:58:16 INFO - 'TMOUT': '86400', 06:58:16 INFO - 'USER': 'cltbld', 06:58:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:16 INFO - '_': '/tools/buildbot/bin/python'} 06:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:16 INFO - Running setup.py (path:/tmp/pip-M_gJ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:16 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)) 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:16 INFO - Running setup.py (path:/tmp/pip-kuMUNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:16 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)) 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:16 INFO - Running setup.py (path:/tmp/pip-qq8psR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:16 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)) 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:16 INFO - Running setup.py (path:/tmp/pip-Gkshif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:16 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)) 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:16 INFO - Running setup.py (path:/tmp/pip-TmeNso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:16 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)) 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:16 INFO - Running setup.py (path:/tmp/pip-2lnFWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:16 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)) 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:16 INFO - Running setup.py (path:/tmp/pip-iyXS8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:17 INFO - Running setup.py (path:/tmp/pip-KQrUGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:17 INFO - Running setup.py (path:/tmp/pip-qRU6_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:17 INFO - Running setup.py (path:/tmp/pip-0Hkany-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:17 INFO - Running setup.py (path:/tmp/pip-RKi9_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:17 INFO - Running setup.py (path:/tmp/pip-hYQO91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:17 INFO - Running setup.py (path:/tmp/pip-9JJLfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:17 INFO - Running setup.py (path:/tmp/pip-rhjYeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:17 INFO - Running setup.py (path:/tmp/pip-64y919-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:17 INFO - Running setup.py (path:/tmp/pip-sx0KET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:17 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)) 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:17 INFO - Running setup.py (path:/tmp/pip-tOYtKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:17 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)) 06:58:17 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)) 06:58:17 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)) 06:58:17 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)) 06:58:17 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)) 06:58:17 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)) 06:58:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:19 INFO - Downloading blessings-1.6.tar.gz 06:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:19 INFO - Installing collected packages: blessings 06:58:19 INFO - Running setup.py install for blessings 06:58:19 INFO - Successfully installed blessings 06:58:19 INFO - Cleaning up... 06:58:19 INFO - Return code: 0 06:58:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:20 INFO - Reading from file tmpfile_stdout 06:58:20 INFO - Current package versions: 06:58:20 INFO - argparse == 1.2.1 06:58:20 INFO - blessings == 1.6 06:58:20 INFO - blobuploader == 1.2.4 06:58:20 INFO - docopt == 0.6.1 06:58:20 INFO - functools32 == 3.2.3-2 06:58:20 INFO - jsonschema == 2.5.1 06:58:20 INFO - manifestparser == 1.1 06:58:20 INFO - mozInstall == 1.12 06:58:20 INFO - mozcrash == 0.17 06:58:20 INFO - mozdebug == 0.1 06:58:20 INFO - mozdevice == 0.48 06:58:20 INFO - mozfile == 1.2 06:58:20 INFO - mozhttpd == 0.7 06:58:20 INFO - mozinfo == 0.9 06:58:20 INFO - mozleak == 0.1 06:58:20 INFO - mozlog == 3.3 06:58:20 INFO - moznetwork == 0.27 06:58:20 INFO - mozprocess == 0.23 06:58:20 INFO - mozprofile == 0.28 06:58:20 INFO - mozrunner == 6.12 06:58:20 INFO - mozscreenshot == 0.1 06:58:20 INFO - mozsystemmonitor == 0.3 06:58:20 INFO - moztest == 0.7 06:58:20 INFO - mozversion == 1.4 06:58:20 INFO - psutil == 3.1.1 06:58:20 INFO - requests == 1.2.3 06:58:20 INFO - wsgiref == 0.1.2 06:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:20 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')]} 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 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')]} 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:20 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 06:58:20 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 06:58:20 INFO - Using env: {'DISPLAY': ':0', 06:58:20 INFO - 'HOME': '/home/cltbld', 06:58:20 INFO - 'LANG': 'en_US.UTF-8', 06:58:20 INFO - 'LANGUAGE': 'en_US:en', 06:58:20 INFO - 'LOGNAME': 'cltbld', 06:58:20 INFO - 'MAIL': '/var/mail/cltbld', 06:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:20 INFO - 'MOZ_NO_REMOTE': '1', 06:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:20 INFO - 'NO_EM_RESTART': '1', 06:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:20 INFO - 'PWD': '/builds/slave/test', 06:58:20 INFO - 'SHELL': '/bin/bash', 06:58:20 INFO - 'SHLVL': '1', 06:58:20 INFO - 'TERM': 'linux', 06:58:20 INFO - 'TMOUT': '86400', 06:58:20 INFO - 'USER': 'cltbld', 06:58:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:20 INFO - '_': '/tools/buildbot/bin/python'} 06:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 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)) 06:58:20 INFO - Cleaning up... 06:58:20 INFO - Return code: 0 06:58:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58:20 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')]} 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 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')]} 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 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 0x11ea030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ab180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, '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': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', '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 06:58:20 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 06:58:20 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 06:58:20 INFO - Using env: {'DISPLAY': ':0', 06:58:20 INFO - 'HOME': '/home/cltbld', 06:58:20 INFO - 'LANG': 'en_US.UTF-8', 06:58:20 INFO - 'LANGUAGE': 'en_US:en', 06:58:20 INFO - 'LOGNAME': 'cltbld', 06:58:20 INFO - 'MAIL': '/var/mail/cltbld', 06:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:20 INFO - 'MOZ_NO_REMOTE': '1', 06:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:20 INFO - 'NO_EM_RESTART': '1', 06:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:20 INFO - 'PWD': '/builds/slave/test', 06:58:20 INFO - 'SHELL': '/bin/bash', 06:58:20 INFO - 'SHLVL': '1', 06:58:20 INFO - 'TERM': 'linux', 06:58:20 INFO - 'TMOUT': '86400', 06:58:20 INFO - 'USER': 'cltbld', 06:58:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:20 INFO - '_': '/tools/buildbot/bin/python'} 06:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:58:20 INFO - Cleaning up... 06:58:20 INFO - Return code: 0 06:58:20 INFO - Running post-action listener: _resource_record_post_action 06:58:20 INFO - Running post-action listener: _start_resource_monitoring 06:58:20 INFO - Starting resource monitoring. 06:58:20 INFO - [mozharness: 2016-07-26 13:58:20.577225Z] Finished create-virtualenv step (success) 06:58:20 INFO - [mozharness: 2016-07-26 13:58:20.577713Z] Running install step. 06:58:20 INFO - Running pre-action listener: _resource_record_pre_action 06:58:20 INFO - Running main action method: install 06:58:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:20 INFO - Reading from file tmpfile_stdout 06:58:20 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:20 INFO - Reading from file tmpfile_stdout 06:58:20 INFO - Output received: 06:58:20 INFO - Usage: mozinstall [options] installer 06:58:20 INFO - Options: 06:58:20 INFO - -h, --help show this help message and exit 06:58:20 INFO - -d DEST, --destination=DEST 06:58:20 INFO - Directory to install application into. [default: 06:58:20 INFO - "/builds/slave/test"] 06:58:20 INFO - --app=APP Application being installed. [default: firefox] 06:58:20 INFO - mkdir: /builds/slave/test/build/application 06:58:20 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'] 06:58:20 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 06:58:37 INFO - Reading from file tmpfile_stdout 06:58:37 INFO - Output received: 06:58:37 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:37 INFO - Running post-action listener: _resource_record_post_action 06:58:37 INFO - [mozharness: 2016-07-26 13:58:37.297513Z] Finished install step (success) 06:58:37 INFO - [mozharness: 2016-07-26 13:58:37.297793Z] Running run-tests step. 06:58:37 INFO - Running pre-action listener: _resource_record_pre_action 06:58:37 INFO - Running main action method: run_tests 06:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:37 INFO - Python 2.7.3 06:58:37 INFO - Return code: 0 06:58:37 INFO - grabbing minidump binary from tooltool 06:58: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')]} 06:58:37 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 0x14a93b0>, '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 0x14aa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:37 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 06:58:37 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 06:58:37 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 06:58:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:37 INFO - Return code: 0 06:58:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:37 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/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 06:58:37 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/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 06:58:37 INFO - Using env: {'DISPLAY': ':0', 06:58:37 INFO - 'HOME': '/home/cltbld', 06:58:37 INFO - 'LANG': 'en_US.UTF-8', 06:58:37 INFO - 'LANGUAGE': 'en_US:en', 06:58:37 INFO - 'LOGNAME': 'cltbld', 06:58:37 INFO - 'MAIL': '/var/mail/cltbld', 06:58:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:37 INFO - 'MOZ_NO_REMOTE': '1', 06:58:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:37 INFO - 'NO_EM_RESTART': '1', 06:58:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:37 INFO - 'PWD': '/builds/slave/test', 06:58:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:37 INFO - 'SHELL': '/bin/bash', 06:58:37 INFO - 'SHLVL': '1', 06:58:37 INFO - 'TERM': 'linux', 06:58:37 INFO - 'TMOUT': '86400', 06:58:37 INFO - 'USER': 'cltbld', 06:58:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062', 06:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:37 INFO - '_': '/tools/buildbot/bin/python'} 06:58:37 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/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 06:58:37 INFO - mozversion application_buildid: 20160726053703 06:58:37 INFO - mozversion application_changeset: 54c8557ec453a787f045d79164bead2e5f95cee7 06:58:37 INFO - mozversion application_display_name: Nightly 06:58:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:37 INFO - mozversion application_name: Firefox 06:58:37 INFO - mozversion application_remotingname: firefox 06:58:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:58:37 INFO - mozversion application_vendor: Mozilla 06:58:37 INFO - mozversion application_version: 50.0a1 06:58:37 INFO - mozversion platform_buildid: 20160726053703 06:58:37 INFO - mozversion platform_changeset: 54c8557ec453a787f045d79164bead2e5f95cee7 06:58:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:58:37 INFO - mozversion platform_version: 50.0a1 06:58:37 INFO - using testdate: 1469541517 06:58:37 INFO - actual date: 1469541517 06:58:37 INFO - starting webserver on 'localhost:53645' 06:58:37 INFO - SUITE-START | Running 2 tests 06:58:37 INFO - TEST-START | dromaeo_css 06:58:37 INFO - operating with platform_type : linux_ 06:58:37 INFO - Initialising browser for dromaeo_css test... 06:58:37 INFO - TEST-INFO | started process 14464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoB87Xa/profile http://localhost:53645/getInfo.html) 06:58:40 INFO - PROCESS | 14464 | JavaScript error: , line 0: uncaught exception: undefined 06:58:41 INFO - PROCESS | 14464 | __metrics Screen width/height:1600/1200 06:58:41 INFO - PROCESS | 14464 | colorDepth:24 06:58:41 INFO - PROCESS | 14464 | Browser inner width/height: 1024/697 06:58:41 INFO - PROCESS | 14464 | __metrics 06:58:42 INFO - PROCESS | 14464 | 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" 06:58:42 INFO - PROCESS | 14464 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:58:43 INFO - TEST-INFO | 14464: exit 0 06:58:43 INFO - Browser initialized. 06:58:43 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:43 INFO - TEST-INFO | started process 14543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoB87Xa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:55 INFO - PROCESS | 14543 | RSS: Main: 158900224 06:58:55 INFO - PROCESS | 14543 | 06:59:45 INFO - PROCESS | 14543 | 1469541585994 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] 07:01:59 INFO - PROCESS | 14543 | Cycle 1(1): loaded http://localhost:53645/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53645/tests/dromaeo/cssquery-ext.html) 07:02:01 INFO - PROCESS | 14543 | RSS: Main: 339066880 07:02:01 INFO - PROCESS | 14543 | 07:05:04 INFO - PROCESS | 14543 | Cycle 1(1): loaded http://localhost:53645/tests/dromaeo/cssquery-ext.html (next: http://localhost:53645/tests/dromaeo/cssquery-jquery.html) 07:05:04 INFO - PROCESS | 14543 | RSS: Main: 252624896 07:05:04 INFO - PROCESS | 14543 | 07:08:07 INFO - PROCESS | 14543 | Cycle 1(1): loaded http://localhost:53645/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53645/tests/dromaeo/cssquery-mootools.html) 07:08:07 INFO - PROCESS | 14543 | RSS: Main: 187559936 07:08:07 INFO - PROCESS | 14543 | 07:11:09 INFO - PROCESS | 14543 | Cycle 1(1): loaded http://localhost:53645/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53645/tests/dromaeo/cssquery-prototype.html) 07:11:10 INFO - PROCESS | 14543 | RSS: Main: 245911552 07:11:10 INFO - PROCESS | 14543 | 07:14:13 INFO - PROCESS | 14543 | Cycle 1(1): loaded http://localhost:53645/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53645/tests/dromaeo/cssquery-yui.html) 07:14:14 INFO - PROCESS | 14543 | RSS: Main: 190570496 07:14:14 INFO - PROCESS | 14543 | 07:17:16 INFO - PROCESS | 14543 | Cycle 1(1): loaded http://localhost:53645/tests/dromaeo/cssquery-yui.html (next: http://localhost:53645/tests/dromaeo/cssquery-dojo.html) 07:17:17 INFO - PROCESS | 14543 | RSS: Main: 284889088 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | __start_tp_report 07:17:17 INFO - PROCESS | 14543 | _x_x_mozilla_page_load 07:17:17 INFO - PROCESS | 14543 | _x_x_mozilla_page_load_details 07:17:17 INFO - PROCESS | 14543 | |i|pagename|runs| 07:17:17 INFO - PROCESS | 14543 | |0;dojo.html;2674.7993900457473;2680.7453291937263;2713.213168181227;2716.82340647858;2724.019353032908;4673.112108699344;4763.833265835688;4765.451973023103;4874.8781280468;4879.243717223827;4759.762011899408;4815.7110573365535;4824.638152138595;4833.516648335165;4886.902261954759;4401.779911004453;4414.757188354639;4431.6233120184825;4438.733675979435;4564.543545645425;4513.255312873388;4513.796879140446;4517.480489743689;4522.977385113087;4536.5236650151755;4240.893977650552;4311.461067366579;4312.22379971605;4395.055063161436;4415.911681766379;4320.805563749639;4336.978315108436;4342.739435633872;4345.087531618364;4347.130573885235;4308.310670292738;4316.6546676265825;4324.718893271959;4325.653947684178;4381.561843815625;4718.079974404993;4815.975920120377;4832.347633069526;4909.435414927293;4922.360093187863;5236.685798852043;5276.234945932818;5292.047431462335;5292.179712144623;5294.047071527124;5016.623753218523;5133.409657889316;5178.016176926372;5198.064348417245;5297.258383826267;4849.078675051729;4851.223804191383;4890.755462226874;4892.2661600760175;4900.068986892479;5326.041312563698;5333.200019997032;5336.759845806948;5341.305630268118;5343.893122137613;4909.0672772173175;5019.84940451787;5035.093683136997;5035.471275516092;5097.490250974873;5121.641485096082;5133.794648214104;5190.6366554341585;5199.584033277329;5203.375594928632;5075.984803039407;5091.1854103343285;5101.897962040738;5104.285400043997;5147.40804807452;4872.3909511311085;4906.632002599819;5077.060743762416;5095.974520127375;5130.461301563357;4449.399331090326;4453.799579018952;4458.398116254329;4488.932666010012;4496.955030449719;3860.6332398422105;3884.475595794588;3894.201688653819;3916.725829191986;3931.64615184629;4321.395004699345;4368.563143685606;4430.756308403004;4460.464744230713;4486.304622783474;5210.53105220532;5211.478852114758;5220.03429365561;5231.346081739783;5260.605454590921;4463.107378524243;4470.329450582439;4474.664400169935;4486.080353527519;4521.050579378301;4528.841490547815;4569.611583015481;4575.7483338416705;4690.976545117321;4742.668013239109;4824;4824.421069471686;4836.298736683091;4853.951460485491;4886;5091.134507133722;5123.897522049613;5126.948730512647;5127.923081153711;5168.224766285088;4724.338592597108;4759.262314341283;4770.403699537558;4794.880127996828;4864.586510146536;5030.144875371123;5041.42023667283;5051.040302342543;5052.621053420935;5052.8484145475695;5080.745962701924;5116.692998420107;5118.257852611276;5128.564072053917;5131.948680513147;5012.6741761786825;5104.489551044866;5109.7700603472185;5110.744462776921;5111.3355263815465;5054.115529782347;5055.7219352935945;5057.216131499624;5065.974670126626;5099.26060721186;4937.0372777308085;4972.801087956441;5027.044861476308;5032.094223039888;5038.924416133834;4921.458639549718;4973.428055773487;4978.27814966835;5049.747512624427;5050.469700681376;4940.160172770709;4940.456549779449;4941.308216849572;4945;4945.060438516671 07:17:17 INFO - PROCESS | 14543 | |1;ext.html;570.6718636783849;590.7341696236693;596.6956852005476;604.2145211225405;608.1637748096367;34707.47938780917;39540.2091958161;39604.20791584174;39610.8019459903;39652;37889.05277368067;38244.80877595615;38310.616893831124;38337.233255334875;38344;7378.151512576042;7568.243175682443;7773.378129749606;9780.951095244514;10012.849807252896;10060.496975151249;10173.287869849113;10183.43991080494;10183.54174062169;10185.236107291945;10230.437325947107;10282;10285.845712314322;10286.279960402775;10287.691369258935;10165.542550585242;10178.287519873611;10210.795784084352;10212.540435680412;10215.591376344937;10041.447720375376;10114.039166279192;10114.140298074672;10119.747006324827;10129.594816207344;37898.43152352717;38293.80853095717;38317;38363.80818095891;38418.231635367134;3046.756259499257;3164.9683503165134;3347.8828241011693;3403.472461768405;3548.6451354864566;29095.12714618565;29435;29718;29827;29873.850630746925;3532.717382609385;3637.7635453695425;3647;3674.8713795017047;3758.530183727034;255402;255599;256052.99999999814;256184;256551;28710.13869583916;29449.263768405533;52829;53464.73267633637;53477;33814.15464613355;34010;34071.31857362839;34116.65883341184;34126;14285.64285892861;14409;14410.919181061463;14412.567622971328;14416.567502974927;10821.458927053773;11691.473883675255;11942.761144777056;12008.279503229835;12257.26456412618;7846.568438735924;7885.921140788633;7968.243016913384;8003.359731221488;8027.1972802719265;3060.495018321952;3121.3913286909287;3157.3211759471824;3161.2254997525292;3167.857446414917;832.4173078844833;860.8966923969164;908.8545832666741;929.9070092990647;970.7718686108759;28014;28342.71657283442;28715.712842871722;28782.136535903956;29192;926.6061923682408;985.3398223190479;992.2359782967219;1005.1707341443339;1047.8009178256107;14623.415063397557;14908.403663853542;14974.384605772835;15233.6191595211;15242.23788810555;401257;404220;404651;407934;408344;48230.517694823306;48525.27212091821;48529;48682.51317486851;48692.51307486951;1124.0614087237248;1183.7810005149247;1213.6905089202373;1230.7538492301576;1242.2111958906341;27808.44383112367;29106.27234319159;29140;29339.70660293455;29600;42326.788366059205;42855.3571696431;43032.354514681676;43070;43071.56928430676;326865;327133;327471;328691;328840;25074.49851002933;26514.86742566352;26515.469690606467;27296.590551142144;27875.86062069758;41768.24119604653;41808.58191418047;41829.372559412244;42263;42328;35374.11564710903;35534.644653553136;35714.10714732153;35901.28197436089;36467;36052.819735901154;36176.27647447089;36497.45253821248;37063.629363706015;37083;35564.822175888956;35664.28671426609;35769.82115089408;35888.10279742923;35964.280714385044;31033.261679492727;32852.835735821165;32961.505577416836;33067;33275;25465.74534254634;25491.49017019612;25840.63012274593;26095.73904261009;26098.739012609632 07:17:17 INFO - PROCESS | 14543 | |2;jquery.html;345.55423503680254;355.3319758853354;365.66906949210966;376.69487714950884;382.8200745649544;12880.355982200888;13527.256000919946;14550.781738273921;17097.487075387726;17146.914265428655;15596.922015389935;16353.83646163538;16710;16713.74929376057;17493.38773142937;4723.8819029524275;4855.4901735317635;4855.951440485603;4858.514148585148;4861.124997500448;3470.2538954124857;5860.472557469827;6079.300880398744;6154.599951003171;6230.719617617218;5984.7306871190685;6008.519318454513;6135.969320153393;6170.382961703816;6174.969125154368;6054.455099041085;6115.480184184327;6137.846553836145;6142.96928515359;6144.662043587601;5412.729363531807;5414.40441551429;6355.968220158916;6720.092787473677;6763.086983257295;22517;22669.43326416853;24264.1507547235;24431.389215269584;24581.13966011199;2126.914923403062;2175.3365223606793;2284.0863654538316;2537.6827896512937;2613.8693065346847;14406.135631862016;14406.495772647908;14621.70756584873;14841.109533428029;15181.772273415907;1871.2140900821687;1922.9230830766753;1925.9325923592746;1948.3765195137562;2027.1587291274104;77407;84779.57610211971;84798.57600712018;85555;88064;16174.433894813625;16679.91660041692;16844.410445634345;17351.30594776195;17636.647267054843;29678.40643187124;29746.553801692993;29773.851130744642;29827.10518684443;29844.55233171504;9389.29580281468;9495.857562136573;9553.522323883779;9576.090271424204;9683;7862.253085956825;7906;8009;8069.515829050276;8151.021877374753;8284.171582841667;8560.871586926201;8680.73957781255;8763.780905477413;8898.644054237759;3049.5883055787626;3179.3482336121037;3182.6976437238427;3426.032891898988;3426.8457919393686;681.8136837730366;720.9134903811577;774.44240147094;873.6767396063498;880.1506546182965;15879;16466.506004819876;16553.6689266214;16812.663746724997;17309.65380692404;845.6279237135641;850.9404341696022;862.8964524257129;866.7096522664851;898.5866501409425;8720.65117395297;9571.090746379083;9579.760505987406;9594.808103837884;9717.951410242904;398650;403120;405436;405551;406022;79093;79940.20059799327;81557;81849;82459;897.0939351255279;904.7059705595708;929.0894922975522;932.4638332958576;934.9252059835197;15756.133412661955;15892.443764468188;16035.839641603434;16353.672926541165;16713.665726685642;38985.220295594496;38996;39902;40523.797381012904;41474;53870;54230.45769542412;54490;54522.45477545174;55349;6797.218319893275;6839.726410943506;6947.44420446353;7020.087388639444;7093.716251349888;8579.914200857911;11703.414829258674;12140.210886292363;12443.253404795742;12815;10503.317284376491;10689.198310126927;10779.89220107789;10818.242723009314;11047.83428248593;10214.131798797185;10371.844422333821;10382.688519344432;10564.947175264075;10774.838377424188;9538.380005299634;9986.151177149733;10629.309094908805;10696.304740191863;10888.346699198073;6925.896111558432;7049.259827718016;7240;7288.271172882669;7351.77944661661;7766.689332426639;9624.278179136452;9956.20350371954;9973.650922217688;10480.475976201007 07:17:17 INFO - PROCESS | 14543 | |3;mootools.html;1378.3521744779953;1435.1962900775566;1489.716953778782;1679.4877562343481;1724.5257554172601;7640;8174.673013079485;8181.427300088996;8184.508929464237;8186.6725330986765;6826.761063362784;7054.329838665319;7513.474056816025;7802.531848089118;8013.719519816807;2205.834562407822;2232.687423760675;2233.3076746208644;2239.317008312464;2241.7870302321335;2171.207509259117;2202.361315218585;2228.765979572146;2232.5423288225957;2235.0277629231337;2201.2075652764993;2216.2464761980923;2227.3206671965045;2232.1852523828848;2232.3191426614876;2143.0998980428258;2157.91368345266;2162.567486502706;2165.133946421436;2165.8700477971374;2163.794439528258;2175.5213852952484;2175.575762726269;2179.814715749163;2184.213683074092;8116.228958248957;8119.066307374668;8156.632951517196;8170.1829817018415;8191;4622.838200662961;4659.627229821606;4706.388169537972;4767.737774422405;4768;3012.9246768830735;3057.6942305769244;3126.3747250549754;3126.8749250029973;3144.339688665383;929.5305870535336;984.7833476635129;985.8866230383526;1696.8303169683056;1762.3126980477623;10744.623938162127;10787.514561844657;10886;10949.562017519369;10969.122470202365;3990.3415936370175;4092.815823287959;4130.318497447947;4241.915161696748;4244.3209086546;8572.914270857336;8576.313894888393;8605.95697021511;8611.181937715906;8619.525926074126;4595.333676616939;4651.186042442627;4656.837010704609;4658.138244424725;4669.369635099218;3701.61133081028;4071.572484889103;4209.684273679486;4328.177646247203;4337.132573485315;3331.3004269103276;3364.4280472319274;3456.792592444461;3458.602260739997;3462.8095454749728;979.6816034788723;988.2538683294067;995.159090568483;996.4370130876032;1003.062136901999;859.8280343931239;872.9170728780756;885.1104639836923;901.3510272603714;906.0169715858367;5431.321084864392;5644.238027866268;5666.320041595035;5686.317641883001;5708.286464191976;892.3619611977467;918.2562124679031;944.9622015119318;965.7006328038331;979.6571200080058;3673.9816300918324;3857.1128640412862;3876.1666241757594;3940.0937784309767;3944.4280579315837;9778.755531111638;9991.500424978867;10088.798224035625;10106.242031847642;10108.29241953071;9651.131398174057;9694.660686875926;10057.094861462358;10059.094681478702;10069.892311845691;7139.107611548557;7294.489385743053;7329.5602263863275;7333.339999399973;7333.669984850694;5326.600504962066;5340.519353258225;5358.571314294769;5439.238506609157;5611.98984182851;8770.12298770118;8779.692710755093;8820.470771753715;8877.422967507091;8898.06570310134;8956;9012.594433250388;9123.31575131881;9124.17882390588;9126.315526335418;5642.971785141048;6277.686115694289;6491.610503369813;6586.5389422739945;6598.736050557924;7469.514481558681;7716.459847810599;7719.575423351769;7727.072751269883;7793.337566306927;6801.5238933274195;6835.555688880406;6914.757983470555;6937.965310173417;7028.437724981887;6629.403353697998;6683.398494135551;6787.62668053242;6940.340667636567;6999.335063168991;6301.212348456443;6411.0383442484;6413.743450261937;6414.550981431255;6422.421982021454;4492.887677808081;4686.390769199982;4742.478327383916;4763.404574428197;4846.103470857903;4598.563136502027;4622.375979242894;4695.272232803921;4826.251930950708;4859.975700121477 07:17:17 INFO - PROCESS | 14543 | |4;prototype.html;275.6457951532281;276.102666334413;281.2743122743322;292.55385537056003;294.3935492884659;4703.85888423347;4865.8540243792695;4873.902521949563;4888.291197776325;4903.60771138309;4623.1678297906365;4759.476967370434;4775.164346239411;4829.734364609945;4839.4918533554;3742.8502859885707;3746.1383881707225;3755.981220093896;3760.830762615675;3764.228333191703;3562.6615471530163;3592.550931133608;3772.5661548921953;3775.320442320381;3776.584575696671;3744.5319335083113;3749.700023998087;3755.3615885299428;3766.5310528893615;3787.621237876218;3725.962740372602;3746.3631182699005;3757.1734218471893;3757.3236817373;3772.5284339457567;3306.35526072416;3313.3042061167184;3318.1041118898;3321.651226621194;3325.0523600773663;4657.4876763555985;4663.370444989951;4679.719216847;4681.57865792077;4779.474257831635;4278.657707383401;4284.978575107136;4286.3784751211215;4288.635465985395;4288.9785551072355;5020.765759237141;5024.542882564052;5029.597632189416;5038.193888977746;5077.796888124471;3356.6811152940677;3512.4906888501023;3610.7472476926628;3636.9272614547826;3647.434647629622;5194.610404219661;5257.631965762398;5264.631475796696;5293.682379057231;5296.841094767163;3624.7100231981376;3628.129248980226;3634.527511423498;3635.0912271932016;3635.618260082706;3689.3912504436466;3705.943806015273;3718.163413232001;3720.311742327678;3721.5162028936065;4154.958450415517;4166.645835103989;4194.538600753915;4215.199112168678;4215.470717569495;5082.593392528663;5089.4147173074825;5103.060836881961;5105.8723531911255;5105.8723531912;1134.3704244144415;1214.6538236602526;1261.1487246109023;1266.316189257809;1274.6239859241546;835.1773503099442;856.2721686566368;860.4407135362064;861.6208868098017;867.6616119713317;4475.373447717322;4489.618382437529;4493.438320209973;4495.550444955544;4496.64026877849;5169.759257778182;5182.585393168538;5185.896282074337;5207.6875387476875;5215.13950198213;4320.783960801948;4506.769149271132;4514.119746649438;4538.682292239578;4543.477500087466;2740.136856890113;2773.015579469259;2784.4570308789594;2787.790915681332;2791.3858951030743;4932.4081110267;4936.136176169156;4938.802447902043;4947.529984651453;4949.331840201598;5135.460776618476;5317.54800841925;5355.86610334737;5360.70516121617;5367.624266301322;4955.702657840541;4970.701757894538;4973.42805577356;4974.5771609413605;4982.327385802871;5115.232715092766;5261.684298942076;5271.262023316815;5281.234221038005;5282.445343238905;5149.356330458692;5154.768035438489;5175.585953123666;5182.689038657692;5182.689038657692;4900.681455705368;4903.583195428429;4922.655414120977;4937.876553086202;4952.439981405845;3617.710583153394;3623.202895363016;3629.7459177858354;3632.9818350908076;3641.126129728793;5034.874128146826;5150.454863540848;5200.583953283653;5200.6879587224885;5216.165413533817;5075.593952483866;5076.619253556072;5076.720780356968;5080.949190508196;5088.185890257541;4939.913219091794;5051.3433253676785;5066.392032956069;5082.288479612783;5089.211172268304;4754.500777418321;4829.541193586604;4974.676646017997;4989.301497790385;5006.924896126634;5090.847274581768;5102.770375333044;5125.256837758429;5125.820596279113;5126.256692779601;5005.574526165171;5005.974970125126;5011.047900898818;5014.019462312293;5019.121653710659 07:17:17 INFO - PROCESS | 14543 | |5;yui.html;653.8300041989082;664.5514277862445;697.2504557600581;735.8417940142868;757.7916073079904;12551.686207844808;13609.047366684335;13630.454781808716;13632.1139125957;13646.454141834327;12976.74046519069;13048.869511304883;13059.347032648377;13072.542461013867;13097.083204175711;632.14344563117;744.3003576637943;764.1937755667768;778.1168373895641;786.5241528875034;768.2202564397141;774.7056118674896;779.197426650548;779.7270955165703;780.8711562592193;827.3960009193293;828.2628460670009;828.45736042892;828.6354004238146;828.70580943765;674.0563211503885;790.2532107158737;826.0376661189707;829.4732844643635;829.8008477965305;599.5772980049055;599.8770252098309;600.1987346891905;600.4535872356134;601.3535449391921;13614.18314901109;13652.522161724291;13655.248961307223;13657.453701851913;13678.794818077737;12662.873371266354;12946.611601651966;13118.260226466335;13139;13237.933810330984;11775.352355620438;12043.759124817541;12105.15263931525;12139.514419423213;12524.874751252462;4064.918701625951;4073.226087043482;4079.8368065277355;4160.83356665736;4168.749875007479;62873.371266287206;63983;64132.67933660348;64982.67508662474;65238;10543.31468454548;10807.567697292177;10986.230963832615;11097.056750176325;11417.657470275904;19983.800161998195;20027.499312517302;20057.097430615657;20067.096980635906;20069.79930200679;6615.272320044791;6635.236947750974;6646.8005959821285;6839;6964.7562335319035;3383.2556837495713;3413.6586341365664;3500.317438099546;3710.9072273193387;3720.088578298334;2777.069681656668;2842.928926776847;2867.7275658812378;2880.6975267597018;2883.163882474059;471.1072517579237;472.3127848979726;476.38784162351214;482.08404032338836;482.56086960865446;526.265859126524;530.8380943812174;561.9381867994517;572.0903763016823;575.3153747041008;7751.3411360035025;7935;8006.479578827474;8079.676812927417;8144.185581441809;445.81498678048894;524.4152769661799;557.3284192548051;571.4143003421526;592.6325678079618;3585.4263317869536;3751.3494062612363;3879.903002424962;3880.4373365861793;4000.0999775050964;48668;75734.24265757271;85404;100022;100255.98720063968;84164.73984109215;84351;85501;86889.5655521731;87337.56331218303;73307;73332.63333683298;74087.62956185185;74833.62583187158;74946;7156.683647453155;7363.226861179499;7377.225391333833;7432.851342973218;7436.851262974818;31336.52995205028;31898.681013189573;42806.35790463083;45035.32447013232;47446.52553474421;36557;51915.48084519258;60514;62647.373526265976;65396.67301663461;8697.56512174376;8766.21104100634;8775.605097770487;8961.059088795844;8965.282777377664;10122.797544049225;10146.289759717045;10148.391096534231;10413.323133996266;10846.728831779268;9385.436873787594;9505.477198753859;9637.566309516229;9687.51562421862;10009.54957026921;9446.149846513847;9614.278929080207;9623.518824058629;9674.129328360481;9778.315517913677;8988.372902596919;9137.77155571116;9141.817163656822;9183.081691830763;9336.626534938527;7973;8048.195180481905;8307.958460207661;8550.657973681233;8815.559222039;7440.2931721486375;7444.664990075568;7985.72049978248;8235;8370.916290837014 07:17:17 INFO - PROCESS | 14543 | __end_tp_report 07:17:17 INFO - PROCESS | 14543 | __start_cc_report 07:17:17 INFO - PROCESS | 14543 | _x_x_mozilla_cycle_collect,2027 07:17:17 INFO - PROCESS | 14543 | __end_cc_report 07:17:17 INFO - PROCESS | 14543 | __startTimestamp1469542637137__endTimestamp 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | ------- Summary: start ------- 07:17:17 INFO - PROCESS | 14543 | Number of tests: 6 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | [#0] dojo.html Cycles:165 Average:4764.30 Median:4892.27 stddev:499.10 (10.2%) stddev-sans-first:472.95 07:17:17 INFO - PROCESS | 14543 | Values: 2674.8 2680.7 2713.2 2716.8 2724.0 4673.1 4763.8 4765.5 4874.9 4879.2 4759.8 4815.7 4824.6 4833.5 4886.9 4401.8 4414.8 4431.6 4438.7 4564.5 4513.3 4513.8 4517.5 4523.0 4536.5 4240.9 4311.5 4312.2 4395.1 4415.9 4320.8 4337.0 4342.7 4345.1 4347.1 4308.3 4316.7 4324.7 4325.7 4381.6 4718.1 4816.0 4832.3 4909.4 4922.4 5236.7 5276.2 5292.0 5292.2 5294.0 5016.6 5133.4 5178.0 5198.1 5297.3 4849.1 4851.2 4890.8 4892.3 4900.1 5326.0 5333.2 5336.8 5341.3 5343.9 4909.1 5019.8 5035.1 5035.5 5097.5 5121.6 5133.8 5190.6 5199.6 5203.4 5076.0 5091.2 5101.9 5104.3 5147.4 4872.4 4906.6 5077.1 5096.0 5130.5 4449.4 4453.8 4458.4 4488.9 4497.0 3860.6 3884.5 3894.2 3916.7 3931.6 4321.4 4368.6 4430.8 4460.5 4486.3 5210.5 5211.5 5220.0 5231.3 5260.6 4463.1 4470.3 4474.7 4486.1 4521.1 4528.8 4569.6 4575.7 4691.0 4742.7 4824.0 4824.4 4836.3 4854.0 4886.0 5091.1 5123.9 5126.9 5127.9 5168.2 4724.3 4759.3 4770.4 4794.9 4864.6 5030.1 5041.4 5051.0 5052.6 5052.8 5080.7 5116.7 5118.3 5128.6 5131.9 5012.7 5104.5 5109.8 5110.7 5111.3 5054.1 5055.7 5057.2 5066.0 5099.3 4937.0 4972.8 5027.0 5032.1 5038.9 4921.5 4973.4 4978.3 5049.7 5050.5 4940.2 4940.5 4941.3 4945.0 4945.1 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | [#1] ext.html Cycles:180 Average:47435.40 Median:33171.00 stddev:88411.88 (266.5%) stddev-sans-first:88589.88 07:17:17 INFO - PROCESS | 14543 | Values: 570.7 590.7 596.7 604.2 608.2 34707.5 39540.2 39604.2 39610.8 39652.0 37889.1 38244.8 38310.6 38337.2 38344.0 7378.2 7568.2 7773.4 9781.0 10012.8 10060.5 10173.3 10183.4 10183.5 10185.2 10230.4 10282.0 10285.8 10286.3 10287.7 10165.5 10178.3 10210.8 10212.5 10215.6 10041.4 10114.0 10114.1 10119.7 10129.6 37898.4 38293.8 38317.0 38363.8 38418.2 3046.8 3165.0 3347.9 3403.5 3548.6 29095.1 29435.0 29718.0 29827.0 29873.9 3532.7 3637.8 3647.0 3674.9 3758.5 255402.0 255599.0 256053.0 256184.0 256551.0 28710.1 29449.3 52829.0 53464.7 53477.0 33814.2 34010.0 34071.3 34116.7 34126.0 14285.6 14409.0 14410.9 14412.6 14416.6 10821.5 11691.5 11942.8 12008.3 12257.3 7846.6 7885.9 7968.2 8003.4 8027.2 3060.5 3121.4 3157.3 3161.2 3167.9 832.4 860.9 908.9 929.9 970.8 28014.0 28342.7 28715.7 28782.1 29192.0 926.6 985.3 992.2 1005.2 1047.8 14623.4 14908.4 14974.4 15233.6 15242.2 401257.0 404220.0 404651.0 407934.0 408344.0 48230.5 48525.3 48529.0 48682.5 48692.5 1124.1 1183.8 1213.7 1230.8 1242.2 27808.4 29106.3 29140.0 29339.7 29600.0 42326.8 42855.4 43032.4 43070.0 43071.6 326865.0 327133.0 327471.0 328691.0 328840.0 25074.5 26514.9 26515.5 27296.6 27875.9 41768.2 41808.6 41829.4 42263.0 42328.0 35374.1 35534.6 35714.1 35901.3 36467.0 36052.8 36176.3 36497.5 37063.6 37083.0 35564.8 35664.3 35769.8 35888.1 35964.3 31033.3 32852.8 32961.5 33067.0 33275.0 25465.7 25491.5 25840.6 26095.7 26098.7 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | [#2] jquery.html Cycles:180 Average:26511.11 Median:4855.72 stddev:66874.19 (1377.2%) stddev-sans-first:67032.93 07:17:17 INFO - PROCESS | 14543 | Values: 345.6 355.3 365.7 376.7 382.8 12880.4 13527.3 14550.8 17097.5 17146.9 15596.9 16353.8 16710.0 16713.7 17493.4 4723.9 4855.5 4856.0 4858.5 4861.1 3470.3 5860.5 6079.3 6154.6 6230.7 5984.7 6008.5 6136.0 6170.4 6175.0 6054.5 6115.5 6137.8 6143.0 6144.7 5412.7 5414.4 6356.0 6720.1 6763.1 22517.0 22669.4 24264.2 24431.4 24581.1 2126.9 2175.3 2284.1 2537.7 2613.9 14406.1 14406.5 14621.7 14841.1 15181.8 1871.2 1922.9 1925.9 1948.4 2027.2 77407.0 84779.6 84798.6 85555.0 88064.0 16174.4 16679.9 16844.4 17351.3 17636.6 29678.4 29746.6 29773.9 29827.1 29844.6 9389.3 9495.9 9553.5 9576.1 9683.0 7862.3 7906.0 8009.0 8069.5 8151.0 8284.2 8560.9 8680.7 8763.8 8898.6 3049.6 3179.3 3182.7 3426.0 3426.8 681.8 720.9 774.4 873.7 880.2 15879.0 16466.5 16553.7 16812.7 17309.7 845.6 850.9 862.9 866.7 898.6 8720.7 9571.1 9579.8 9594.8 9718.0 398650.0 403120.0 405436.0 405551.0 406022.0 79093.0 79940.2 81557.0 81849.0 82459.0 897.1 904.7 929.1 932.5 934.9 15756.1 15892.4 16035.8 16353.7 16713.7 38985.2 38996.0 39902.0 40523.8 41474.0 53870.0 54230.5 54490.0 54522.5 55349.0 6797.2 6839.7 6947.4 7020.1 7093.7 8579.9 11703.4 12140.2 12443.3 12815.0 10503.3 10689.2 10779.9 10818.2 11047.8 10214.1 10371.8 10382.7 10564.9 10774.8 9538.4 9986.2 10629.3 10696.3 10888.3 6925.9 7049.3 7240.0 7288.3 7351.8 7766.7 9624.3 9956.2 9973.7 10480.5 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | [#3] mootools.html Cycles:180 Average:5206.49 Median:5349.55 stddev:2893.91 (54.1%) stddev-sans-first:2887.73 07:17:17 INFO - PROCESS | 14543 | Values: 1378.4 1435.2 1489.7 1679.5 1724.5 7640.0 8174.7 8181.4 8184.5 8186.7 6826.8 7054.3 7513.5 7802.5 8013.7 2205.8 2232.7 2233.3 2239.3 2241.8 2171.2 2202.4 2228.8 2232.5 2235.0 2201.2 2216.2 2227.3 2232.2 2232.3 2143.1 2157.9 2162.6 2165.1 2165.9 2163.8 2175.5 2175.6 2179.8 2184.2 8116.2 8119.1 8156.6 8170.2 8191.0 4622.8 4659.6 4706.4 4767.7 4768.0 3012.9 3057.7 3126.4 3126.9 3144.3 929.5 984.8 985.9 1696.8 1762.3 10744.6 10787.5 10886.0 10949.6 10969.1 3990.3 4092.8 4130.3 4241.9 4244.3 8572.9 8576.3 8606.0 8611.2 8619.5 4595.3 4651.2 4656.8 4658.1 4669.4 3701.6 4071.6 4209.7 4328.2 4337.1 3331.3 3364.4 3456.8 3458.6 3462.8 979.7 988.3 995.2 996.4 1003.1 859.8 872.9 885.1 901.4 906.0 5431.3 5644.2 5666.3 5686.3 5708.3 892.4 918.3 945.0 965.7 979.7 3674.0 3857.1 3876.2 3940.1 3944.4 9778.8 9991.5 10088.8 10106.2 10108.3 9651.1 9694.7 10057.1 10059.1 10069.9 7139.1 7294.5 7329.6 7333.3 7333.7 5326.6 5340.5 5358.6 5439.2 5612.0 8770.1 8779.7 8820.5 8877.4 8898.1 8956.0 9012.6 9123.3 9124.2 9126.3 5643.0 6277.7 6491.6 6586.5 6598.7 7469.5 7716.5 7719.6 7727.1 7793.3 6801.5 6835.6 6914.8 6938.0 7028.4 6629.4 6683.4 6787.6 6940.3 6999.3 6301.2 6411.0 6413.7 6414.6 6422.4 4492.9 4686.4 4742.5 4763.4 4846.1 4598.6 4622.4 4695.3 4826.3 4860.0 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | [#4] prototype.html Cycles:180 Average:4199.18 Median:4829.64 stddev:1233.61 (25.5%) stddev-sans-first:1201.40 07:17:17 INFO - PROCESS | 14543 | Values: 275.6 276.1 281.3 292.6 294.4 4703.9 4865.9 4873.9 4888.3 4903.6 4623.2 4759.5 4775.2 4829.7 4839.5 3742.9 3746.1 3756.0 3760.8 3764.2 3562.7 3592.6 3772.6 3775.3 3776.6 3744.5 3749.7 3755.4 3766.5 3787.6 3726.0 3746.4 3757.2 3757.3 3772.5 3306.4 3313.3 3318.1 3321.7 3325.1 4657.5 4663.4 4679.7 4681.6 4779.5 4278.7 4285.0 4286.4 4288.6 4289.0 5020.8 5024.5 5029.6 5038.2 5077.8 3356.7 3512.5 3610.7 3636.9 3647.4 5194.6 5257.6 5264.6 5293.7 5296.8 3624.7 3628.1 3634.5 3635.1 3635.6 3689.4 3705.9 3718.2 3720.3 3721.5 4155.0 4166.6 4194.5 4215.2 4215.5 5082.6 5089.4 5103.1 5105.9 5105.9 1134.4 1214.7 1261.1 1266.3 1274.6 835.2 856.3 860.4 861.6 867.7 4475.4 4489.6 4493.4 4495.6 4496.6 5169.8 5182.6 5185.9 5207.7 5215.1 4320.8 4506.8 4514.1 4538.7 4543.5 2740.1 2773.0 2784.5 2787.8 2791.4 4932.4 4936.1 4938.8 4947.5 4949.3 5135.5 5317.5 5355.9 5360.7 5367.6 4955.7 4970.7 4973.4 4974.6 4982.3 5115.2 5261.7 5271.3 5281.2 5282.4 5149.4 5154.8 5175.6 5182.7 5182.7 4900.7 4903.6 4922.7 4937.9 4952.4 3617.7 3623.2 3629.7 3633.0 3641.1 5034.9 5150.5 5200.6 5200.7 5216.2 5075.6 5076.6 5076.7 5080.9 5088.2 4939.9 5051.3 5066.4 5082.3 5089.2 4754.5 4829.5 4974.7 4989.3 5006.9 5090.8 5102.8 5125.3 5125.8 5126.3 5005.6 5006.0 5011.0 5014.0 5019.1 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - PROCESS | 14543 | [#5] yui.html Cycles:180 Average:16767.43 Median:30557.68 stddev:24167.16 (79.1%) stddev-sans-first:24204.67 07:17:17 INFO - PROCESS | 14543 | Values: 653.8 664.6 697.3 735.8 757.8 12551.7 13609.0 13630.5 13632.1 13646.5 12976.7 13048.9 13059.3 13072.5 13097.1 632.1 744.3 764.2 778.1 786.5 768.2 774.7 779.2 779.7 780.9 827.4 828.3 828.5 828.6 828.7 674.1 790.3 826.0 829.5 829.8 599.6 599.9 600.2 600.5 601.4 13614.2 13652.5 13655.2 13657.5 13678.8 12662.9 12946.6 13118.3 13139.0 13237.9 11775.4 12043.8 12105.2 12139.5 12524.9 4064.9 4073.2 4079.8 4160.8 4168.7 62873.4 63983.0 64132.7 64982.7 65238.0 10543.3 10807.6 10986.2 11097.1 11417.7 19983.8 20027.5 20057.1 20067.1 20069.8 6615.3 6635.2 6646.8 6839.0 6964.8 3383.3 3413.7 3500.3 3710.9 3720.1 2777.1 2842.9 2867.7 2880.7 2883.2 471.1 472.3 476.4 482.1 482.6 526.3 530.8 561.9 572.1 575.3 7751.3 7935.0 8006.5 8079.7 8144.2 445.8 524.4 557.3 571.4 592.6 3585.4 3751.3 3879.9 3880.4 4000.1 48668.0 75734.2 85404.0 100022.0 100256.0 84164.7 84351.0 85501.0 86889.6 87337.6 73307.0 73332.6 74087.6 74833.6 74946.0 7156.7 7363.2 7377.2 7432.9 7436.9 31336.5 31898.7 42806.4 45035.3 47446.5 36557.0 51915.5 60514.0 62647.4 65396.7 8697.6 8766.2 8775.6 8961.1 8965.3 10122.8 10146.3 10148.4 10413.3 10846.7 9385.4 9505.5 9637.6 9687.5 10009.5 9446.1 9614.3 9623.5 9674.1 9778.3 8988.4 9137.8 9141.8 9183.1 9336.6 7973.0 8048.2 8308.0 8550.7 8815.6 7440.3 7444.7 7985.7 8235.0 8370.9 07:17:17 INFO - PROCESS | 14543 | -------- Summary: end -------- 07:17:17 INFO - PROCESS | 14543 | 07:17:17 INFO - TEST-INFO | 14543: exit 0 07:17:17 INFO - TEST-OK | dromaeo_css | took 1120353ms 07:17:17 INFO - TEST-START | kraken 07:17:17 INFO - operating with platform_type : linux_ 07:17:17 INFO - Initialising browser for kraken test... 07:17:17 INFO - TEST-INFO | started process 14729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9mMCXk/profile http://localhost:53645/getInfo.html) 07:17:21 INFO - PROCESS | 14729 | JavaScript error: , line 0: uncaught exception: undefined 07:17:21 INFO - PROCESS | 14729 | __metrics Screen width/height:1600/1200 07:17:21 INFO - PROCESS | 14729 | colorDepth:24 07:17:21 INFO - PROCESS | 14729 | Browser inner width/height: 1024/697 07:17:21 INFO - PROCESS | 14729 | __metrics 07:17:22 INFO - PROCESS | 14729 | 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" 07:17:22 INFO - PROCESS | 14729 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:23 INFO - TEST-INFO | 14729: exit 0 07:17:23 INFO - Browser initialized. 07:17:23 INFO - Running cycle 1/1 for kraken test... 07:17:23 INFO - TEST-INFO | started process 14808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9mMCXk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:35 INFO - PROCESS | 14808 | RSS: Main: 159703040 07:17:35 INFO - PROCESS | 14808 | 07:17:38 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53645/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:39 INFO - PROCESS | 14808 | RSS: Main: 215900160 07:17:39 INFO - PROCESS | 14808 | 07:17:41 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53645/tests/kraken/driver.html?testName=audio-dft) 07:17:42 INFO - PROCESS | 14808 | RSS: Main: 193245184 07:17:42 INFO - PROCESS | 14808 | 07:17:45 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53645/tests/kraken/driver.html?testName=audio-fft) 07:17:46 INFO - PROCESS | 14808 | RSS: Main: 272297984 07:17:46 INFO - PROCESS | 14808 | 07:17:48 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53645/tests/kraken/driver.html?testName=audio-oscillator) 07:17:49 INFO - PROCESS | 14808 | RSS: Main: 182910976 07:17:49 INFO - PROCESS | 14808 | 07:17:51 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53645/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:52 INFO - PROCESS | 14808 | RSS: Main: 187088896 07:17:52 INFO - PROCESS | 14808 | 07:17:55 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53645/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:55 INFO - PROCESS | 14808 | RSS: Main: 223739904 07:17:55 INFO - PROCESS | 14808 | 07:17:59 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53645/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:59 INFO - PROCESS | 14808 | RSS: Main: 216817664 07:18:00 INFO - PROCESS | 14808 | 07:18:02 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53645/tests/kraken/driver.html?testName=json-parse-financial) 07:18:03 INFO - PROCESS | 14808 | RSS: Main: 220696576 07:18:03 INFO - PROCESS | 14808 | 07:18:05 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53645/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:05 INFO - PROCESS | 14808 | RSS: Main: 186462208 07:18:05 INFO - PROCESS | 14808 | 07:18:07 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:08 INFO - PROCESS | 14808 | RSS: Main: 190533632 07:18:08 INFO - PROCESS | 14808 | 07:18:10 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:11 INFO - PROCESS | 14808 | RSS: Main: 196132864 07:18:11 INFO - PROCESS | 14808 | 07:18:13 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:14 INFO - PROCESS | 14808 | RSS: Main: 191819776 07:18:14 INFO - PROCESS | 14808 | 07:18:17 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:18 INFO - PROCESS | 14808 | RSS: Main: 194195456 07:18:18 INFO - PROCESS | 14808 | 07:18:19 INFO - PROCESS | 14808 | Cycle 1(1): loaded http://localhost:53645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53645/tests/kraken/driver.html?testName=ai-astar) 07:18:20 INFO - PROCESS | 14808 | RSS: Main: 244682752 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | __start_tp_report 07:18:20 INFO - PROCESS | 14808 | _x_x_mozilla_page_load 07:18:20 INFO - PROCESS | 14808 | _x_x_mozilla_page_load_details 07:18:20 INFO - PROCESS | 14808 | |i|pagename|runs| 07:18:20 INFO - PROCESS | 14808 | |0;ai-astar;106;113;115;115;114;113;114;114;113;112 07:18:20 INFO - PROCESS | 14808 | |1;audio-beat-detection;147;123;124;177;127;129;145;121;165;124 07:18:20 INFO - PROCESS | 14808 | |2;audio-dft;161;161;162;162;162;162;162;160;160;161 07:18:20 INFO - PROCESS | 14808 | |3;audio-fft;75;77;76;124;76;76;74;77;99;76 07:18:20 INFO - PROCESS | 14808 | |4;audio-oscillator;85;84;125;86;85;85;109;85;85;123 07:18:20 INFO - PROCESS | 14808 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 07:18:20 INFO - PROCESS | 14808 | |6;imaging-darkroom;147;147;147;147;147;147;148;147;147;146 07:18:20 INFO - PROCESS | 14808 | |7;imaging-desaturate;95;95;94;95;95;95;95;94;95;95 07:18:20 INFO - PROCESS | 14808 | |8;json-parse-financial;61;61;60;62;61;61;61;61;61;61 07:18:20 INFO - PROCESS | 14808 | |9;json-stringify-tinderbox;65;66;65;66;66;65;66;66;67;69 07:18:20 INFO - PROCESS | 14808 | |10;stanford-crypto-aes;79;78;79;79;79;79;79;79;79;79 07:18:20 INFO - PROCESS | 14808 | |11;stanford-crypto-ccm;139;140;134;143;147;129;128;126;167;142 07:18:20 INFO - PROCESS | 14808 | |12;stanford-crypto-pbkdf2;166;164;163;163;162;165;166;165;163;166 07:18:20 INFO - PROCESS | 14808 | |13;stanford-crypto-sha256-iterative;68;67;71;67;67;66;67;71;76;67 07:18:20 INFO - PROCESS | 14808 | __end_tp_report 07:18:20 INFO - PROCESS | 14808 | __start_cc_report 07:18:20 INFO - PROCESS | 14808 | _x_x_mozilla_cycle_collect,1948 07:18:20 INFO - PROCESS | 14808 | __end_cc_report 07:18:20 INFO - PROCESS | 14808 | __startTimestamp1469542700037__endTimestamp 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | ------- Summary: start ------- 07:18:20 INFO - PROCESS | 14808 | Number of tests: 14 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.60 (2.3%) stddev-sans-first:1.00 07:18:20 INFO - PROCESS | 14808 | Values: 106.0 113.0 115.0 115.0 114.0 113.0 114.0 114.0 113.0 112.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:137.00 stddev:19.69 (14.4%) stddev-sans-first:20.62 07:18:20 INFO - PROCESS | 14808 | Values: 147.0 123.0 124.0 177.0 127.0 129.0 145.0 121.0 165.0 124.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:18:20 INFO - PROCESS | 14808 | Values: 161.0 161.0 162.0 162.0 162.0 162.0 162.0 160.0 160.0 161.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:16.16 (21.3%) stddev-sans-first:16.88 07:18:20 INFO - PROCESS | 14808 | Values: 75.0 77.0 76.0 124.0 76.0 76.0 74.0 77.0 99.0 76.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:85.00 stddev:16.94 (19.9%) stddev-sans-first:17.56 07:18:20 INFO - PROCESS | 14808 | Values: 85.0 84.0 125.0 86.0 85.0 85.0 109.0 85.0 85.0 123.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:18:20 INFO - PROCESS | 14808 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 07:18:20 INFO - PROCESS | 14808 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:18:20 INFO - PROCESS | 14808 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 07:18:20 INFO - PROCESS | 14808 | Values: 61.0 61.0 60.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 07:18:20 INFO - PROCESS | 14808 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 66.0 66.0 67.0 69.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 07:18:20 INFO - PROCESS | 14808 | Values: 79.0 78.0 79.0 79.0 79.0 79.0 79.0 79.0 79.0 79.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:141.00 stddev:11.96 (8.5%) stddev-sans-first:12.68 07:18:20 INFO - PROCESS | 14808 | Values: 139.0 140.0 134.0 143.0 147.0 129.0 128.0 126.0 167.0 142.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:165.00 stddev:1.49 (0.9%) stddev-sans-first:1.45 07:18:20 INFO - PROCESS | 14808 | Values: 166.0 164.0 163.0 163.0 162.0 165.0 166.0 165.0 163.0 166.0 07:18:20 INFO - PROCESS | 14808 | 07:18:20 INFO - PROCESS | 14808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:67.50 stddev:3.09 (4.6%) stddev-sans-first:3.27 07:18:20 INFO - PROCESS | 14808 | Values: 68.0 67.0 71.0 67.0 67.0 66.0 67.0 71.0 76.0 67.0 07:18:20 INFO - PROCESS | 14808 | -------- Summary: end -------- 07:18:20 INFO - PROCESS | 14808 | 07:18:21 INFO - TEST-INFO | 14808: exit 0 07:18:21 INFO - TEST-OK | kraken | took 63237ms 07:18:21 INFO - SUITE-END | took 1183s 07:18:21 INFO - Completed test suite (00:19:43) 07:18:21 INFO - javascript benchmark 07:18:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.7993900457473, 2680.7453291937263, 2713.213168181227, 2716.82340647858, 2724.019353032908, 4673.112108699344, 4763.833265835688, 4765.451973023103, 4874.8781280468, 4879.243717223827, 4759.762011899408, 4815.7110573365535, 4824.638152138595, 4833.516648335165, 4886.902261954759, 4401.779911004453, 4414.757188354639, 4431.6233120184825, 4438.733675979435, 4564.543545645425, 4513.255312873388, 4513.796879140446, 4517.480489743689, 4522.977385113087, 4536.5236650151755, 4240.893977650552, 4311.461067366579, 4312.22379971605, 4395.055063161436, 4415.911681766379, 4320.805563749639, 4336.978315108436, 4342.739435633872, 4345.087531618364, 4347.130573885235, 4308.310670292738, 4316.6546676265825, 4324.718893271959, 4325.653947684178, 4381.561843815625, 4718.079974404993, 4815.975920120377, 4832.347633069526, 4909.435414927293, 4922.360093187863, 5236.685798852043, 5276.234945932818, 5292.047431462335, 5292.179712144623, 5294.047071527124, 5016.623753218523, 5133.409657889316, 5178.016176926372, 5198.064348417245, 5297.258383826267, 4849.078675051729, 4851.223804191383, 4890.755462226874, 4892.2661600760175, 4900.068986892479, 5326.041312563698, 5333.200019997032, 5336.759845806948, 5341.305630268118, 5343.893122137613, 4909.0672772173175, 5019.84940451787, 5035.093683136997, 5035.471275516092, 5097.490250974873, 5121.641485096082, 5133.794648214104, 5190.6366554341585, 5199.584033277329, 5203.375594928632, 5075.984803039407, 5091.1854103343285, 5101.897962040738, 5104.285400043997, 5147.40804807452, 4872.3909511311085, 4906.632002599819, 5077.060743762416, 5095.974520127375, 5130.461301563357, 4449.399331090326, 4453.799579018952, 4458.398116254329, 4488.932666010012, 4496.955030449719, 3860.6332398422105, 3884.475595794588, 3894.201688653819, 3916.725829191986, 3931.64615184629, 4321.395004699345, 4368.563143685606, 4430.756308403004, 4460.464744230713, 4486.304622783474, 5210.53105220532, 5211.478852114758, 5220.03429365561, 5231.346081739783, 5260.605454590921, 4463.107378524243, 4470.329450582439, 4474.664400169935, 4486.080353527519, 4521.050579378301, 4528.841490547815, 4569.611583015481, 4575.7483338416705, 4690.976545117321, 4742.668013239109, 4824.0, 4824.421069471686, 4836.298736683091, 4853.951460485491, 4886.0, 5091.134507133722, 5123.897522049613, 5126.948730512647, 5127.923081153711, 5168.224766285088, 4724.338592597108, 4759.262314341283, 4770.403699537558, 4794.880127996828, 4864.586510146536, 5030.144875371123, 5041.42023667283, 5051.040302342543, 5052.621053420935, 5052.8484145475695, 5080.745962701924, 5116.692998420107, 5118.257852611276, 5128.564072053917, 5131.948680513147, 5012.6741761786825, 5104.489551044866, 5109.7700603472185, 5110.744462776921, 5111.3355263815465, 5054.115529782347, 5055.7219352935945, 5057.216131499624, 5065.974670126626, 5099.26060721186, 4937.0372777308085, 4972.801087956441, 5027.044861476308, 5032.094223039888, 5038.924416133834, 4921.458639549718, 4973.428055773487, 4978.27814966835, 5049.747512624427, 5050.469700681376, 4940.160172770709, 4940.456549779449, 4941.308216849572, 4945.0, 4945.060438516671], "value": 4732.616529265701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6718636783849, 590.7341696236693, 596.6956852005476, 604.2145211225405, 608.1637748096367, 34707.47938780917, 39540.2091958161, 39604.20791584174, 39610.8019459903, 39652.0, 37889.05277368067, 38244.80877595615, 38310.616893831124, 38337.233255334875, 38344.0, 7378.151512576042, 7568.243175682443, 7773.378129749606, 9780.951095244514, 10012.849807252896, 10060.496975151249, 10173.287869849113, 10183.43991080494, 10183.54174062169, 10185.236107291945, 10230.437325947107, 10282.0, 10285.845712314322, 10286.279960402775, 10287.691369258935, 10165.542550585242, 10178.287519873611, 10210.795784084352, 10212.540435680412, 10215.591376344937, 10041.447720375376, 10114.039166279192, 10114.140298074672, 10119.747006324827, 10129.594816207344, 37898.43152352717, 38293.80853095717, 38317.0, 38363.80818095891, 38418.231635367134, 3046.756259499257, 3164.9683503165134, 3347.8828241011693, 3403.472461768405, 3548.6451354864566, 29095.12714618565, 29435.0, 29718.0, 29827.0, 29873.850630746925, 3532.717382609385, 3637.7635453695425, 3647.0, 3674.8713795017047, 3758.530183727034, 255402.0, 255599.0, 256052.99999999814, 256184.0, 256551.0, 28710.13869583916, 29449.263768405533, 52829.0, 53464.73267633637, 53477.0, 33814.15464613355, 34010.0, 34071.31857362839, 34116.65883341184, 34126.0, 14285.64285892861, 14409.0, 14410.919181061463, 14412.567622971328, 14416.567502974927, 10821.458927053773, 11691.473883675255, 11942.761144777056, 12008.279503229835, 12257.26456412618, 7846.568438735924, 7885.921140788633, 7968.243016913384, 8003.359731221488, 8027.1972802719265, 3060.495018321952, 3121.3913286909287, 3157.3211759471824, 3161.2254997525292, 3167.857446414917, 832.4173078844833, 860.8966923969164, 908.8545832666741, 929.9070092990647, 970.7718686108759, 28014.0, 28342.71657283442, 28715.712842871722, 28782.136535903956, 29192.0, 926.6061923682408, 985.3398223190479, 992.2359782967219, 1005.1707341443339, 1047.8009178256107, 14623.415063397557, 14908.403663853542, 14974.384605772835, 15233.6191595211, 15242.23788810555, 401257.0, 404220.0, 404651.0, 407934.0, 408344.0, 48230.517694823306, 48525.27212091821, 48529.0, 48682.51317486851, 48692.51307486951, 1124.0614087237248, 1183.7810005149247, 1213.6905089202373, 1230.7538492301576, 1242.2111958906341, 27808.44383112367, 29106.27234319159, 29140.0, 29339.70660293455, 29600.0, 42326.788366059205, 42855.3571696431, 43032.354514681676, 43070.0, 43071.56928430676, 326865.0, 327133.0, 327471.0, 328691.0, 328840.0, 25074.49851002933, 26514.86742566352, 26515.469690606467, 27296.590551142144, 27875.86062069758, 41768.24119604653, 41808.58191418047, 41829.372559412244, 42263.0, 42328.0, 35374.11564710903, 35534.644653553136, 35714.10714732153, 35901.28197436089, 36467.0, 36052.819735901154, 36176.27647447089, 36497.45253821248, 37063.629363706015, 37083.0, 35564.822175888956, 35664.28671426609, 35769.82115089408, 35888.10279742923, 35964.280714385044, 31033.261679492727, 32852.835735821165, 32961.505577416836, 33067.0, 33275.0, 25465.74534254634, 25491.49017019612, 25840.63012274593, 26095.73904261009, 26098.739012609632], "value": 17174.058837373006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.55423503680254, 355.3319758853354, 365.66906949210966, 376.69487714950884, 382.8200745649544, 12880.355982200888, 13527.256000919946, 14550.781738273921, 17097.487075387726, 17146.914265428655, 15596.922015389935, 16353.83646163538, 16710.0, 16713.74929376057, 17493.38773142937, 4723.8819029524275, 4855.4901735317635, 4855.951440485603, 4858.514148585148, 4861.124997500448, 3470.2538954124857, 5860.472557469827, 6079.300880398744, 6154.599951003171, 6230.719617617218, 5984.7306871190685, 6008.519318454513, 6135.969320153393, 6170.382961703816, 6174.969125154368, 6054.455099041085, 6115.480184184327, 6137.846553836145, 6142.96928515359, 6144.662043587601, 5412.729363531807, 5414.40441551429, 6355.968220158916, 6720.092787473677, 6763.086983257295, 22517.0, 22669.43326416853, 24264.1507547235, 24431.389215269584, 24581.13966011199, 2126.914923403062, 2175.3365223606793, 2284.0863654538316, 2537.6827896512937, 2613.8693065346847, 14406.135631862016, 14406.495772647908, 14621.70756584873, 14841.109533428029, 15181.772273415907, 1871.2140900821687, 1922.9230830766753, 1925.9325923592746, 1948.3765195137562, 2027.1587291274104, 77407.0, 84779.57610211971, 84798.57600712018, 85555.0, 88064.0, 16174.433894813625, 16679.91660041692, 16844.410445634345, 17351.30594776195, 17636.647267054843, 29678.40643187124, 29746.553801692993, 29773.851130744642, 29827.10518684443, 29844.55233171504, 9389.29580281468, 9495.857562136573, 9553.522323883779, 9576.090271424204, 9683.0, 7862.253085956825, 7906.0, 8009.0, 8069.515829050276, 8151.021877374753, 8284.171582841667, 8560.871586926201, 8680.73957781255, 8763.780905477413, 8898.644054237759, 3049.5883055787626, 3179.3482336121037, 3182.6976437238427, 3426.032891898988, 3426.8457919393686, 681.8136837730366, 720.9134903811577, 774.44240147094, 873.6767396063498, 880.1506546182965, 15879.0, 16466.506004819876, 16553.6689266214, 16812.663746724997, 17309.65380692404, 845.6279237135641, 850.9404341696022, 862.8964524257129, 866.7096522664851, 898.5866501409425, 8720.65117395297, 9571.090746379083, 9579.760505987406, 9594.808103837884, 9717.951410242904, 398650.0, 403120.0, 405436.0, 405551.0, 406022.0, 79093.0, 79940.20059799327, 81557.0, 81849.0, 82459.0, 897.0939351255279, 904.7059705595708, 929.0894922975522, 932.4638332958576, 934.9252059835197, 15756.133412661955, 15892.443764468188, 16035.839641603434, 16353.672926541165, 16713.665726685642, 38985.220295594496, 38996.0, 39902.0, 40523.797381012904, 41474.0, 53870.0, 54230.45769542412, 54490.0, 54522.45477545174, 55349.0, 6797.218319893275, 6839.726410943506, 6947.44420446353, 7020.087388639444, 7093.716251349888, 8579.914200857911, 11703.414829258674, 12140.210886292363, 12443.253404795742, 12815.0, 10503.317284376491, 10689.198310126927, 10779.89220107789, 10818.242723009314, 11047.83428248593, 10214.131798797185, 10371.844422333821, 10382.688519344432, 10564.947175264075, 10774.838377424188, 9538.380005299634, 9986.151177149733, 10629.309094908805, 10696.304740191863, 10888.346699198073, 6925.896111558432, 7049.259827718016, 7240.0, 7288.271172882669, 7351.77944661661, 7766.689332426639, 9624.278179136452, 9956.20350371954, 9973.650922217688, 10480.475976201007], "value": 9241.71761674508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.3521744779953, 1435.1962900775566, 1489.716953778782, 1679.4877562343481, 1724.5257554172601, 7640.0, 8174.673013079485, 8181.427300088996, 8184.508929464237, 8186.6725330986765, 6826.761063362784, 7054.329838665319, 7513.474056816025, 7802.531848089118, 8013.719519816807, 2205.834562407822, 2232.687423760675, 2233.3076746208644, 2239.317008312464, 2241.7870302321335, 2171.207509259117, 2202.361315218585, 2228.765979572146, 2232.5423288225957, 2235.0277629231337, 2201.2075652764993, 2216.2464761980923, 2227.3206671965045, 2232.1852523828848, 2232.3191426614876, 2143.0998980428258, 2157.91368345266, 2162.567486502706, 2165.133946421436, 2165.8700477971374, 2163.794439528258, 2175.5213852952484, 2175.575762726269, 2179.814715749163, 2184.213683074092, 8116.228958248957, 8119.066307374668, 8156.632951517196, 8170.1829817018415, 8191.0, 4622.838200662961, 4659.627229821606, 4706.388169537972, 4767.737774422405, 4768.0, 3012.9246768830735, 3057.6942305769244, 3126.3747250549754, 3126.8749250029973, 3144.339688665383, 929.5305870535336, 984.7833476635129, 985.8866230383526, 1696.8303169683056, 1762.3126980477623, 10744.623938162127, 10787.514561844657, 10886.0, 10949.562017519369, 10969.122470202365, 3990.3415936370175, 4092.815823287959, 4130.318497447947, 4241.915161696748, 4244.3209086546, 8572.914270857336, 8576.313894888393, 8605.95697021511, 8611.181937715906, 8619.525926074126, 4595.333676616939, 4651.186042442627, 4656.837010704609, 4658.138244424725, 4669.369635099218, 3701.61133081028, 4071.572484889103, 4209.684273679486, 4328.177646247203, 4337.132573485315, 3331.3004269103276, 3364.4280472319274, 3456.792592444461, 3458.602260739997, 3462.8095454749728, 979.6816034788723, 988.2538683294067, 995.159090568483, 996.4370130876032, 1003.062136901999, 859.8280343931239, 872.9170728780756, 885.1104639836923, 901.3510272603714, 906.0169715858367, 5431.321084864392, 5644.238027866268, 5666.320041595035, 5686.317641883001, 5708.286464191976, 892.3619611977467, 918.2562124679031, 944.9622015119318, 965.7006328038331, 979.6571200080058, 3673.9816300918324, 3857.1128640412862, 3876.1666241757594, 3940.0937784309767, 3944.4280579315837, 9778.755531111638, 9991.500424978867, 10088.798224035625, 10106.242031847642, 10108.29241953071, 9651.131398174057, 9694.660686875926, 10057.094861462358, 10059.094681478702, 10069.892311845691, 7139.107611548557, 7294.489385743053, 7329.5602263863275, 7333.339999399973, 7333.669984850694, 5326.600504962066, 5340.519353258225, 5358.571314294769, 5439.238506609157, 5611.98984182851, 8770.12298770118, 8779.692710755093, 8820.470771753715, 8877.422967507091, 8898.06570310134, 8956.0, 9012.594433250388, 9123.31575131881, 9124.17882390588, 9126.315526335418, 5642.971785141048, 6277.686115694289, 6491.610503369813, 6586.5389422739945, 6598.736050557924, 7469.514481558681, 7716.459847810599, 7719.575423351769, 7727.072751269883, 7793.337566306927, 6801.5238933274195, 6835.555688880406, 6914.757983470555, 6937.965310173417, 7028.437724981887, 6629.403353697998, 6683.398494135551, 6787.62668053242, 6940.340667636567, 6999.335063168991, 6301.212348456443, 6411.0383442484, 6413.743450261937, 6414.550981431255, 6422.421982021454, 4492.887677808081, 4686.390769199982, 4742.478327383916, 4763.404574428197, 4846.103470857903, 4598.563136502027, 4622.375979242894, 4695.272232803921, 4826.251930950708, 4859.975700121477], "value": 4223.20298943703, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.6457951532281, 276.102666334413, 281.2743122743322, 292.55385537056003, 294.3935492884659, 4703.85888423347, 4865.8540243792695, 4873.902521949563, 4888.291197776325, 4903.60771138309, 4623.1678297906365, 4759.476967370434, 4775.164346239411, 4829.734364609945, 4839.4918533554, 3742.8502859885707, 3746.1383881707225, 3755.981220093896, 3760.830762615675, 3764.228333191703, 3562.6615471530163, 3592.550931133608, 3772.5661548921953, 3775.320442320381, 3776.584575696671, 3744.5319335083113, 3749.700023998087, 3755.3615885299428, 3766.5310528893615, 3787.621237876218, 3725.962740372602, 3746.3631182699005, 3757.1734218471893, 3757.3236817373, 3772.5284339457567, 3306.35526072416, 3313.3042061167184, 3318.1041118898, 3321.651226621194, 3325.0523600773663, 4657.4876763555985, 4663.370444989951, 4679.719216847, 4681.57865792077, 4779.474257831635, 4278.657707383401, 4284.978575107136, 4286.3784751211215, 4288.635465985395, 4288.9785551072355, 5020.765759237141, 5024.542882564052, 5029.597632189416, 5038.193888977746, 5077.796888124471, 3356.6811152940677, 3512.4906888501023, 3610.7472476926628, 3636.9272614547826, 3647.434647629622, 5194.610404219661, 5257.631965762398, 5264.631475796696, 5293.682379057231, 5296.841094767163, 3624.7100231981376, 3628.129248980226, 3634.527511423498, 3635.0912271932016, 3635.618260082706, 3689.3912504436466, 3705.943806015273, 3718.163413232001, 3720.311742327678, 3721.5162028936065, 4154.958450415517, 4166.645835103989, 4194.538600753915, 4215.199112168678, 4215.470717569495, 5082.593392528663, 5089.4147173074825, 5103.060836881961, 5105.8723531911255, 5105.8723531912, 1134.3704244144415, 1214.6538236602526, 1261.1487246109023, 1266.316189257809, 1274.6239859241546, 835.1773503099442, 856.2721686566368, 860.4407135362064, 861.6208868098017, 867.6616119713317, 4475.373447717322, 4489.618382437529, 4493.438320209973, 4495.550444955544, 4496.64026877849, 5169.759257778182, 5182.585393168538, 5185.896282074337, 5207.6875387476875, 5215.13950198213, 4320.783960801948, 4506.769149271132, 4514.119746649438, 4538.682292239578, 4543.477500087466, 2740.136856890113, 2773.015579469259, 2784.4570308789594, 2787.790915681332, 2791.3858951030743, 4932.4081110267, 4936.136176169156, 4938.802447902043, 4947.529984651453, 4949.331840201598, 5135.460776618476, 5317.54800841925, 5355.86610334737, 5360.70516121617, 5367.624266301322, 4955.702657840541, 4970.701757894538, 4973.42805577356, 4974.5771609413605, 4982.327385802871, 5115.232715092766, 5261.684298942076, 5271.262023316815, 5281.234221038005, 5282.445343238905, 5149.356330458692, 5154.768035438489, 5175.585953123666, 5182.689038657692, 5182.689038657692, 4900.681455705368, 4903.583195428429, 4922.655414120977, 4937.876553086202, 4952.439981405845, 3617.710583153394, 3623.202895363016, 3629.7459177858354, 3632.9818350908076, 3641.126129728793, 5034.874128146826, 5150.454863540848, 5200.583953283653, 5200.6879587224885, 5216.165413533817, 5075.593952483866, 5076.619253556072, 5076.720780356968, 5080.949190508196, 5088.185890257541, 4939.913219091794, 5051.3433253676785, 5066.392032956069, 5082.288479612783, 5089.211172268304, 4754.500777418321, 4829.541193586604, 4974.676646017997, 4989.301497790385, 5006.924896126634, 5090.847274581768, 5102.770375333044, 5125.256837758429, 5125.820596279113, 5126.256692779601, 5005.574526165171, 5005.974970125126, 5011.047900898818, 5014.019462312293, 5019.121653710659], "value": 3800.455568943706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.8300041989082, 664.5514277862445, 697.2504557600581, 735.8417940142868, 757.7916073079904, 12551.686207844808, 13609.047366684335, 13630.454781808716, 13632.1139125957, 13646.454141834327, 12976.74046519069, 13048.869511304883, 13059.347032648377, 13072.542461013867, 13097.083204175711, 632.14344563117, 744.3003576637943, 764.1937755667768, 778.1168373895641, 786.5241528875034, 768.2202564397141, 774.7056118674896, 779.197426650548, 779.7270955165703, 780.8711562592193, 827.3960009193293, 828.2628460670009, 828.45736042892, 828.6354004238146, 828.70580943765, 674.0563211503885, 790.2532107158737, 826.0376661189707, 829.4732844643635, 829.8008477965305, 599.5772980049055, 599.8770252098309, 600.1987346891905, 600.4535872356134, 601.3535449391921, 13614.18314901109, 13652.522161724291, 13655.248961307223, 13657.453701851913, 13678.794818077737, 12662.873371266354, 12946.611601651966, 13118.260226466335, 13139.0, 13237.933810330984, 11775.352355620438, 12043.759124817541, 12105.15263931525, 12139.514419423213, 12524.874751252462, 4064.918701625951, 4073.226087043482, 4079.8368065277355, 4160.83356665736, 4168.749875007479, 62873.371266287206, 63983.0, 64132.67933660348, 64982.67508662474, 65238.0, 10543.31468454548, 10807.567697292177, 10986.230963832615, 11097.056750176325, 11417.657470275904, 19983.800161998195, 20027.499312517302, 20057.097430615657, 20067.096980635906, 20069.79930200679, 6615.272320044791, 6635.236947750974, 6646.8005959821285, 6839.0, 6964.7562335319035, 3383.2556837495713, 3413.6586341365664, 3500.317438099546, 3710.9072273193387, 3720.088578298334, 2777.069681656668, 2842.928926776847, 2867.7275658812378, 2880.6975267597018, 2883.163882474059, 471.1072517579237, 472.3127848979726, 476.38784162351214, 482.08404032338836, 482.56086960865446, 526.265859126524, 530.8380943812174, 561.9381867994517, 572.0903763016823, 575.3153747041008, 7751.3411360035025, 7935.0, 8006.479578827474, 8079.676812927417, 8144.185581441809, 445.81498678048894, 524.4152769661799, 557.3284192548051, 571.4143003421526, 592.6325678079618, 3585.4263317869536, 3751.3494062612363, 3879.903002424962, 3880.4373365861793, 4000.0999775050964, 48668.0, 75734.24265757271, 85404.0, 100022.0, 100255.98720063968, 84164.73984109215, 84351.0, 85501.0, 86889.5655521731, 87337.56331218303, 73307.0, 73332.63333683298, 74087.62956185185, 74833.62583187158, 74946.0, 7156.683647453155, 7363.226861179499, 7377.225391333833, 7432.851342973218, 7436.851262974818, 31336.52995205028, 31898.681013189573, 42806.35790463083, 45035.32447013232, 47446.52553474421, 36557.0, 51915.48084519258, 60514.0, 62647.373526265976, 65396.67301663461, 8697.56512174376, 8766.21104100634, 8775.605097770487, 8961.059088795844, 8965.282777377664, 10122.797544049225, 10146.289759717045, 10148.391096534231, 10413.323133996266, 10846.728831779268, 9385.436873787594, 9505.477198753859, 9637.566309516229, 9687.51562421862, 10009.54957026921, 9446.149846513847, 9614.278929080207, 9623.518824058629, 9674.129328360481, 9778.315517913677, 8988.372902596919, 9137.77155571116, 9141.817163656822, 9183.081691830763, 9336.626534938527, 7973.0, 8048.195180481905, 8307.958460207661, 8550.657973681233, 8815.559222039, 7440.2931721486375, 7444.664990075568, 7985.72049978248, 8235.0, 8370.916290837014], "value": 6248.986722690439, "unit": "score"}], "name": "dromaeo_css", "value": 6498.961695816691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 124.0, 177.0, 127.0, 129.0, 145.0, 121.0, 165.0, 124.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 160.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 124.0, 76.0, 76.0, 74.0, 77.0, 99.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 125.0, 86.0, 85.0, 85.0, 109.0, 85.0, 85.0, 123.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 69.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 134.0, 143.0, 147.0, 129.0, 128.0, 126.0, 167.0, 142.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 163.0, 162.0, 165.0, 166.0, 165.0, 163.0, 166.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 71.0, 67.0, 67.0, 66.0, 67.0, 71.0, 76.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1528.0, "alertThreshold": 2.0}]} 07:18:21 INFO - Return code: 0 07:18:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:18:21 INFO - # TBPL SUCCESS # 07:18:21 INFO - Running post-action listener: _resource_record_post_action 07:18:21 INFO - [mozharness: 2016-07-26 14:18:21.325884Z] Finished run-tests step (success) 07:18:21 INFO - Running post-run listener: _resource_record_post_run 07:18:21 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556933120; Read time: 16; Write time: 404780 07:18:21 INFO - TinderboxPrint: CPU usage
13.0% 07:18:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:18:21 INFO - TinderboxPrint: I/O write bytes / time
556,933,120 / 404,780 07:18:21 INFO - TinderboxPrint: CPU idle
8,335.1 (87.0%) 07:18:21 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 07:18:21 INFO - TinderboxPrint: Swap in / out
0 / 0 07:18:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246812672; Read time: 0; Write time: 215060 07:18:21 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288505856; Read time: 16; Write time: 178156 07:18:21 INFO - Running post-run listener: _upload_blobber_files 07:18:21 INFO - Blob upload gear active. 07:18:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:21 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 07:18:21 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'] 07:18:21 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 07:18:22 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:29 INFO - (blobuploader) - INFO - Done attempting. 07:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:18:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:30 INFO - (blobuploader) - INFO - Done attempting. 07:18:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:18:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:18:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:31 INFO - (blobuploader) - INFO - Done attempting. 07:18:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:31 INFO - Return code: 0 07:18:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38511879ee26ae3f833cbf01525e9fcdb736a4b2d3afe11ac22e9122496101cc8836bc57be065da8c347dd610164a008eb96fe66aede2e44815b321ba586e6d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9aefcfa8536e351e890173f46e5ebbc0b6a94345e8347ba260dba4c7e3a4090d04219aae41e6c0a5bfaee86be9e334f206b7402e199356acfa846cb8252713b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51e34a3fba4ad8a0a5944080e2683092831a4b1a55398ea2f4283a071c02940b6665aaf571ef65a3301cc88f0f72b3a32f7cce837eb7dc61d09699de3e622a9a"} 07:18:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:31 INFO - Contents: 07:18:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38511879ee26ae3f833cbf01525e9fcdb736a4b2d3afe11ac22e9122496101cc8836bc57be065da8c347dd610164a008eb96fe66aede2e44815b321ba586e6d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9aefcfa8536e351e890173f46e5ebbc0b6a94345e8347ba260dba4c7e3a4090d04219aae41e6c0a5bfaee86be9e334f206b7402e199356acfa846cb8252713b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51e34a3fba4ad8a0a5944080e2683092831a4b1a55398ea2f4283a071c02940b6665aaf571ef65a3301cc88f0f72b3a32f7cce837eb7dc61d09699de3e622a9a"} 07:18:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:31 INFO - Copying logs to upload dir... 07:18:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.088752 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-26 07:18:31.272254) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 07:18:31.279804) ========= 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=1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062 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/38511879ee26ae3f833cbf01525e9fcdb736a4b2d3afe11ac22e9122496101cc8836bc57be065da8c347dd610164a008eb96fe66aede2e44815b321ba586e6d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9aefcfa8536e351e890173f46e5ebbc0b6a94345e8347ba260dba4c7e3a4090d04219aae41e6c0a5bfaee86be9e334f206b7402e199356acfa846cb8252713b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51e34a3fba4ad8a0a5944080e2683092831a4b1a55398ea2f4283a071c02940b6665aaf571ef65a3301cc88f0f72b3a32f7cce837eb7dc61d09699de3e622a9a"} build_url:https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/FKOE3rd7R5mhi9qkN38-7w/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/38511879ee26ae3f833cbf01525e9fcdb736a4b2d3afe11ac22e9122496101cc8836bc57be065da8c347dd610164a008eb96fe66aede2e44815b321ba586e6d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9aefcfa8536e351e890173f46e5ebbc0b6a94345e8347ba260dba4c7e3a4090d04219aae41e6c0a5bfaee86be9e334f206b7402e199356acfa846cb8252713b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51e34a3fba4ad8a0a5944080e2683092831a4b1a55398ea2f4283a071c02940b6665aaf571ef65a3301cc88f0f72b3a32f7cce837eb7dc61d09699de3e622a9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 07:18:31.308523) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:18:31.308877) ========= 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=1f5564757af27664ca02d71f000001b0-1469541466.527456-1428970062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 07:18:31.388294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 07:18:31.391624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 07:18:31.391946) ========= ========= Total master_lag: 0.19 =========