builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1469721660.95 results: success (0) buildid: 20160728074632 builduid: f3e638a3d9e1437db8a0d1a259f54143 revision: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:00.947190) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:00.947675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:00.947943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:00.970083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:00.970378) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 09:01:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 45.7M=0s 2016-07-28 09:01:01 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121831 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.113444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.113855) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.164033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.164414) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 75f7f076c3a84c8095b81ecfb208e82c5d74db32 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 75f7f076c3a84c8095b81ecfb208e82c5d74db32 --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=14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 09:01:01,404 truncating revision to first 12 chars 2016-07-28 09:01:01,404 Setting DEBUG logging. 2016-07-28 09:01:01,404 attempt 1/10 2016-07-28 09:01:01,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/75f7f076c3a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 09:01:01,735 unpacking tar archive at: fx-team-75f7f076c3a8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.839748) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.840090) ========= script_repo_revision: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.840504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.840765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 09:01:01.856730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-28 09:01:01.857122) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:01:02 INFO - MultiFileLogger online at 20160728 09:01:02 in /builds/slave/test 09:01:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:01:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:01:02 INFO - {'append_to_log': False, 09:01:02 INFO - 'base_work_dir': '/builds/slave/test', 09:01:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:01:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:01:02 INFO - 'branch': 'Fx-Team-Non-PGO', 09:01:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:02 INFO - 'config_files': ('talos/linux_config.py',), 09:01:02 INFO - 'default_actions': ('clobber', 09:01:02 INFO - 'read-buildbot-config', 09:01:02 INFO - 'download-and-extract', 09:01:02 INFO - 'populate-webroot', 09:01:02 INFO - 'create-virtualenv', 09:01:02 INFO - 'install', 09:01:02 INFO - 'run-tests'), 09:01:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:02 INFO - 'download_minidump_stackwalk': True, 09:01:02 INFO - 'download_symbols': 'ondemand', 09:01:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:02 INFO - 'installer_path': 'installer.exe', 09:01:02 INFO - 'log_level': 'info', 09:01:02 INFO - 'log_name': 'talos', 09:01:02 INFO - 'log_to_console': True, 09:01:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:01:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:01:02 INFO - 'opt_config_files': (), 09:01:02 INFO - 'pip_index': False, 09:01:02 INFO - 'sps_profile': False, 09:01:02 INFO - 'sps_profile_interval': 0, 09:01:02 INFO - 'suite': 'dromaeojs', 09:01:02 INFO - 'system_bits': '32', 09:01:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:02 INFO - 'title': 'talos-linux64-ix-036', 09:01:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:02 INFO - 'use_talos_json': True, 09:01:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:01:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:02 INFO - 'work_dir': 'build'} 09:01:02 INFO - [mozharness: 2016-07-28 16:01:02.178942Z] Running clobber step. 09:01:02 INFO - Running pre-action listener: _resource_record_pre_action 09:01:02 INFO - Running main action method: clobber 09:01:02 INFO - rmtree: /builds/slave/test/build 09:01:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:01:02 INFO - Running post-action listener: _resource_record_post_action 09:01:02 INFO - [mozharness: 2016-07-28 16:01:02.654217Z] Finished clobber step (success) 09:01:02 INFO - [mozharness: 2016-07-28 16:01:02.654317Z] Running read-buildbot-config step. 09:01:02 INFO - Running pre-action listener: _resource_record_pre_action 09:01:02 INFO - Running main action method: read_buildbot_config 09:01:02 INFO - Using buildbot properties: 09:01:02 INFO - { 09:01:02 INFO - "project": "", 09:01:02 INFO - "product": "firefox", 09:01:02 INFO - "script_repo_revision": "production", 09:01:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:01:02 INFO - "repository": "", 09:01:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:01:02 INFO - "buildid": "20160728074632", 09:01:02 INFO - "pgo_build": "False", 09:01:02 INFO - "basedir": "/builds/slave/test", 09:01:02 INFO - "buildnumber": 2028, 09:01:02 INFO - "slavename": "talos-linux64-ix-036", 09:01:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:01:02 INFO - "platform": "ubuntu64_hw", 09:01:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:01:02 INFO - "branch": "fx-team", 09:01:02 INFO - "repo_path": "integration/fx-team", 09:01:02 INFO - "revision": "75f7f076c3a84c8095b81ecfb208e82c5d74db32", 09:01:02 INFO - "stage_platform": "linux64", 09:01:02 INFO - "builduid": "f3e638a3d9e1437db8a0d1a259f54143", 09:01:02 INFO - "slavebuilddir": "test" 09:01:02 INFO - } 09:01:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:01:02 INFO - Running post-action listener: _resource_record_post_action 09:01:02 INFO - [mozharness: 2016-07-28 16:01:02.656724Z] Finished read-buildbot-config step (success) 09:01:02 INFO - [mozharness: 2016-07-28 16:01:02.656813Z] Running download-and-extract step. 09:01:02 INFO - Running pre-action listener: _resource_record_pre_action 09:01:02 INFO - Running main action method: download_and_extract 09:01:02 INFO - mkdir: /builds/slave/test/build/tests 09:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:02 INFO - https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:01:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:01:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:01:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:04 INFO - Downloaded 1361 bytes. 09:01:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:01:04 INFO - Using the following test package requirements: 09:01:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:01:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:01:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'jsshell-linux-x86_64.zip'], 09:01:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:01:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:01:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:01:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:01:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:01:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:04 INFO - https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:01:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:01:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:05 INFO - Downloaded 22746624 bytes. 09:01:05 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'] 09:01:05 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 09:01:06 INFO - Return code: 0 09:01:06 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 09:01: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')]} 09:01:06 INFO - https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:22 INFO - Downloaded 22746624 bytes. 09:01:22 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'] 09:01:22 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 09:01:23 INFO - Return code: 0 09:01:23 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')]} 09:01:23 INFO - https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:24 INFO - Downloaded 14413725 bytes. 09:01:24 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'] 09:01:24 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 09:01:24 INFO - Return code: 0 09:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:24 INFO - https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:01:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:01:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:01:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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 09:01:26 INFO - Downloaded 57149921 bytes. 09:01:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:01:26 INFO - mkdir: /builds/slave/test/properties 09:01:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:26 INFO - Contents: 09:01:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:01:27 INFO - Running post-action listener: _resource_record_post_action 09:01:27 INFO - Running post-action listener: set_extra_try_arguments 09:01:27 INFO - [mozharness: 2016-07-28 16:01:27.022222Z] Finished download-and-extract step (success) 09:01:27 INFO - [mozharness: 2016-07-28 16:01:27.022543Z] Running populate-webroot step. 09:01:27 INFO - Running pre-action listener: _resource_record_pre_action 09:01:27 INFO - Running main action method: populate_webroot 09:01:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:27 INFO - '--tppagecycles', 09:01:27 INFO - '7'], 09:01:27 INFO - 'tests': ['tsvgm']}}, 09:01:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:01:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:01:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:01:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['damp', 'tps']}, 09:01:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'tests': ['damp', 'tps']}, 09:01:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['dromaeo_dom']}, 09:01:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['basic_compositor_video']}, 09:01:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:01:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['a11yr', 09:01:27 INFO - 'ts_paint', 09:01:27 INFO - 'tpaint', 09:01:27 INFO - 'sessionrestore', 09:01:27 INFO - 'sessionrestore_no_auto_restore', 09:01:27 INFO - 'tabpaint']}, 09:01:27 INFO - 'other-e10s': {'tests': ['a11yr', 09:01:27 INFO - 'ts_paint', 09:01:27 INFO - 'tpaint', 09:01:27 INFO - 'sessionrestore', 09:01:27 INFO - 'sessionrestore_no_auto_restore', 09:01:27 INFO - 'tabpaint']}, 09:01:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:01:27 INFO - 'ts_paint', 09:01:27 INFO - 'tpaint', 09:01:27 INFO - 'sessionrestore', 09:01:27 INFO - 'sessionrestore_no_auto_restore', 09:01:27 INFO - 'tabpaint']}, 09:01:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:01:27 INFO - 'ts_paint', 09:01:27 INFO - 'tpaint', 09:01:27 INFO - 'sessionrestore', 09:01:27 INFO - 'sessionrestore_no_auto_restore', 09:01:27 INFO - 'tabpaint']}, 09:01:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['a11yr', 09:01:27 INFO - 'ts_paint', 09:01:27 INFO - 'tpaint', 09:01:27 INFO - 'sessionrestore', 09:01:27 INFO - 'sessionrestore_no_auto_restore', 09:01:27 INFO - 'tabpaint']}, 09:01:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['a11yr', 09:01:27 INFO - 'ts_paint', 09:01:27 INFO - 'tpaint', 09:01:27 INFO - 'sessionrestore', 09:01:27 INFO - 'sessionrestore_no_auto_restore', 09:01:27 INFO - 'tabpaint']}, 09:01:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['tsvgx', 09:01:27 INFO - 'tsvgr_opacity', 09:01:27 INFO - 'tart', 09:01:27 INFO - 'tscrollx', 09:01:27 INFO - 'cart']}, 09:01:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:01:27 INFO - 'tsvgr_opacity', 09:01:27 INFO - 'tart', 09:01:27 INFO - 'tscrollx', 09:01:27 INFO - 'cart']}, 09:01:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'talos_options': ['--disable-e10s'], 09:01:27 INFO - 'tests': ['tp5o']}, 09:01:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'tests': ['tp5o']}, 09:01:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'talos_options': ['--disable-e10s', 09:01:27 INFO - '--xperf_path', 09:01:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:27 INFO - 'tests': ['tp5n']}, 09:01:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:27 INFO - 'talos_options': ['--xperf_path', 09:01:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:27 INFO - 'tests': ['tp5n']}}, 09:01:27 INFO - 'talos.zip': {'path': '', 09:01:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:27 INFO - Running post-action listener: _resource_record_post_action 09:01:27 INFO - [mozharness: 2016-07-28 16:01:27.041401Z] Finished populate-webroot step (success) 09:01:27 INFO - [mozharness: 2016-07-28 16:01:27.041489Z] Running create-virtualenv step. 09:01:27 INFO - Running pre-action listener: _resource_record_pre_action 09:01:27 INFO - Running main action method: create_virtualenv 09:01:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:27 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 09:01:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:27 INFO - Using real prefix '/usr' 09:01:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:29 INFO - Installing pip.................done. 09:01:29 INFO - Return code: 0 09:01:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:01:29 INFO - Using env: {'DISPLAY': ':0', 09:01:29 INFO - 'HOME': '/home/cltbld', 09:01:29 INFO - 'LANG': 'en_US.UTF-8', 09:01:29 INFO - 'LANGUAGE': 'en_US:en', 09:01:29 INFO - 'LOGNAME': 'cltbld', 09:01:29 INFO - 'MAIL': '/var/mail/cltbld', 09:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:29 INFO - 'MOZ_NO_REMOTE': '1', 09:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:29 INFO - 'NO_EM_RESTART': '1', 09:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:29 INFO - 'PWD': '/builds/slave/test', 09:01:29 INFO - 'SHELL': '/bin/bash', 09:01:29 INFO - 'SHLVL': '1', 09:01:29 INFO - 'TERM': 'linux', 09:01:29 INFO - 'TMOUT': '86400', 09:01:29 INFO - 'USER': 'cltbld', 09:01:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:29 INFO - '_': '/tools/buildbot/bin/python'} 09:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:29 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 09:01:29 INFO - Cleaning up... 09:01:29 INFO - Return code: 0 09:01:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:01:29 INFO - Using env: {'DISPLAY': ':0', 09:01:29 INFO - 'HOME': '/home/cltbld', 09:01:29 INFO - 'LANG': 'en_US.UTF-8', 09:01:29 INFO - 'LANGUAGE': 'en_US:en', 09:01:29 INFO - 'LOGNAME': 'cltbld', 09:01:29 INFO - 'MAIL': '/var/mail/cltbld', 09:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:29 INFO - 'MOZ_NO_REMOTE': '1', 09:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:29 INFO - 'NO_EM_RESTART': '1', 09:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:29 INFO - 'PWD': '/builds/slave/test', 09:01:29 INFO - 'SHELL': '/bin/bash', 09:01:29 INFO - 'SHLVL': '1', 09:01:29 INFO - 'TERM': 'linux', 09:01:29 INFO - 'TMOUT': '86400', 09:01:29 INFO - 'USER': 'cltbld', 09:01:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:29 INFO - '_': '/tools/buildbot/bin/python'} 09:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:30 INFO - Downloading/unpacking psutil>=3.1.1 09:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:32 INFO - Installing collected packages: psutil 09:01:32 INFO - Running setup.py install for psutil 09:01:32 INFO - building 'psutil._psutil_linux' extension 09:01:32 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 09:01:32 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 09:01:32 INFO - building 'psutil._psutil_posix' extension 09:01:32 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 09:01:32 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 09:01:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:32 INFO - Successfully installed psutil 09:01:32 INFO - Cleaning up... 09:01:32 INFO - Return code: 0 09:01:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:01:32 INFO - Using env: {'DISPLAY': ':0', 09:01:32 INFO - 'HOME': '/home/cltbld', 09:01:32 INFO - 'LANG': 'en_US.UTF-8', 09:01:32 INFO - 'LANGUAGE': 'en_US:en', 09:01:32 INFO - 'LOGNAME': 'cltbld', 09:01:32 INFO - 'MAIL': '/var/mail/cltbld', 09:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:32 INFO - 'MOZ_NO_REMOTE': '1', 09:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:32 INFO - 'NO_EM_RESTART': '1', 09:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:32 INFO - 'PWD': '/builds/slave/test', 09:01:32 INFO - 'SHELL': '/bin/bash', 09:01:32 INFO - 'SHLVL': '1', 09:01:32 INFO - 'TERM': 'linux', 09:01:32 INFO - 'TMOUT': '86400', 09:01:32 INFO - 'USER': 'cltbld', 09:01:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:32 INFO - '_': '/tools/buildbot/bin/python'} 09:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:01:34 INFO - Installing collected packages: mozsystemmonitor 09:01:34 INFO - Running setup.py install for mozsystemmonitor 09:01:34 INFO - Successfully installed mozsystemmonitor 09:01:34 INFO - Cleaning up... 09:01:35 INFO - Return code: 0 09:01:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:01:35 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')]} 09:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:35 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')]} 09:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:35 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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:35 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 09:01:35 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 09:01:35 INFO - Using env: {'DISPLAY': ':0', 09:01:35 INFO - 'HOME': '/home/cltbld', 09:01:35 INFO - 'LANG': 'en_US.UTF-8', 09:01:35 INFO - 'LANGUAGE': 'en_US:en', 09:01:35 INFO - 'LOGNAME': 'cltbld', 09:01:35 INFO - 'MAIL': '/var/mail/cltbld', 09:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:35 INFO - 'MOZ_NO_REMOTE': '1', 09:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:35 INFO - 'NO_EM_RESTART': '1', 09:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:35 INFO - 'PWD': '/builds/slave/test', 09:01:35 INFO - 'SHELL': '/bin/bash', 09:01:35 INFO - 'SHLVL': '1', 09:01:35 INFO - 'TERM': 'linux', 09:01:35 INFO - 'TMOUT': '86400', 09:01:35 INFO - 'USER': 'cltbld', 09:01:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:35 INFO - '_': '/tools/buildbot/bin/python'} 09:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:35 INFO - Downloading/unpacking jsonschema==2.5.1 09:01:35 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 09:01:35 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 09:01:35 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 09:01:35 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 09:01:35 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 09:01:35 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 09:01:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:01:37 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 09:01:37 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 09:01:37 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 09:01:37 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 09:01:37 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 09:01:37 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 09:01:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:37 INFO - warning: no files found matching '*.txt' 09:01:37 INFO - no previously-included directories found matching 'build' 09:01:37 INFO - no previously-included directories found matching 'dist' 09:01:37 INFO - no previously-included directories found matching '.git*' 09:01:37 INFO - Installing collected packages: jsonschema, functools32 09:01:37 INFO - Running setup.py install for functools32 09:01:37 INFO - warning: no files found matching '*.txt' 09:01:37 INFO - no previously-included directories found matching 'build' 09:01:37 INFO - no previously-included directories found matching 'dist' 09:01:37 INFO - no previously-included directories found matching '.git*' 09:01:37 INFO - Successfully installed jsonschema functools32 09:01:37 INFO - Cleaning up... 09:01:37 INFO - Return code: 0 09:01:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:01:37 INFO - Using env: {'DISPLAY': ':0', 09:01:37 INFO - 'HOME': '/home/cltbld', 09:01:37 INFO - 'LANG': 'en_US.UTF-8', 09:01:37 INFO - 'LANGUAGE': 'en_US:en', 09:01:37 INFO - 'LOGNAME': 'cltbld', 09:01:37 INFO - 'MAIL': '/var/mail/cltbld', 09:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:37 INFO - 'MOZ_NO_REMOTE': '1', 09:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:37 INFO - 'NO_EM_RESTART': '1', 09:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:37 INFO - 'PWD': '/builds/slave/test', 09:01:37 INFO - 'SHELL': '/bin/bash', 09:01:37 INFO - 'SHLVL': '1', 09:01:37 INFO - 'TERM': 'linux', 09:01:37 INFO - 'TMOUT': '86400', 09:01:37 INFO - 'USER': 'cltbld', 09:01:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:37 INFO - '_': '/tools/buildbot/bin/python'} 09:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:01:37 INFO - Cleaning up... 09:01:37 INFO - Return code: 0 09:01:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:01:37 INFO - Using env: {'DISPLAY': ':0', 09:01:37 INFO - 'HOME': '/home/cltbld', 09:01:37 INFO - 'LANG': 'en_US.UTF-8', 09:01:37 INFO - 'LANGUAGE': 'en_US:en', 09:01:37 INFO - 'LOGNAME': 'cltbld', 09:01:37 INFO - 'MAIL': '/var/mail/cltbld', 09:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:37 INFO - 'MOZ_NO_REMOTE': '1', 09:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:37 INFO - 'NO_EM_RESTART': '1', 09:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:37 INFO - 'PWD': '/builds/slave/test', 09:01:37 INFO - 'SHELL': '/bin/bash', 09:01:37 INFO - 'SHLVL': '1', 09:01:37 INFO - 'TERM': 'linux', 09:01:37 INFO - 'TMOUT': '86400', 09:01:37 INFO - 'USER': 'cltbld', 09:01:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:37 INFO - '_': '/tools/buildbot/bin/python'} 09:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01:39 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 09:01:39 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 09:01:39 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 09:01:39 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 09:01:39 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 09:01:39 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 09:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:01:40 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 09:01:40 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 09:01:40 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 09:01:40 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 09:01:40 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 09:01:40 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 09:01:40 INFO - Downloading docopt-0.6.1.tar.gz 09:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:40 INFO - Running setup.py install for blobuploader 09:01:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:40 INFO - Running setup.py install for requests 09:01:41 INFO - Running setup.py install for docopt 09:01:41 INFO - Successfully installed blobuploader requests docopt 09:01:41 INFO - Cleaning up... 09:01:41 INFO - Return code: 0 09:01:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:41 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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:41 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 09:01:41 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 09:01:41 INFO - Using env: {'DISPLAY': ':0', 09:01:41 INFO - 'HOME': '/home/cltbld', 09:01:41 INFO - 'LANG': 'en_US.UTF-8', 09:01:41 INFO - 'LANGUAGE': 'en_US:en', 09:01:41 INFO - 'LOGNAME': 'cltbld', 09:01:41 INFO - 'MAIL': '/var/mail/cltbld', 09:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:41 INFO - 'MOZ_NO_REMOTE': '1', 09:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:41 INFO - 'NO_EM_RESTART': '1', 09:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:41 INFO - 'PWD': '/builds/slave/test', 09:01:41 INFO - 'SHELL': '/bin/bash', 09:01:41 INFO - 'SHLVL': '1', 09:01:41 INFO - 'TERM': 'linux', 09:01:41 INFO - 'TMOUT': '86400', 09:01:41 INFO - 'USER': 'cltbld', 09:01:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:41 INFO - '_': '/tools/buildbot/bin/python'} 09:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:41 INFO - Running setup.py (path:/tmp/pip-e5jFAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:41 INFO - Running setup.py (path:/tmp/pip-JlQfTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:41 INFO - Running setup.py (path:/tmp/pip-BpE3VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:41 INFO - Running setup.py (path:/tmp/pip-pU1ZLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:41 INFO - Running setup.py (path:/tmp/pip-Karl5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:41 INFO - Running setup.py (path:/tmp/pip-RnF4eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:41 INFO - Running setup.py (path:/tmp/pip-KNMzx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:41 INFO - Running setup.py (path:/tmp/pip-Huo_Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:42 INFO - Running setup.py (path:/tmp/pip-jTTE5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:42 INFO - Running setup.py (path:/tmp/pip-IiaTe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:42 INFO - Running setup.py (path:/tmp/pip-2k9sQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:42 INFO - Running setup.py (path:/tmp/pip-pu2ILy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:42 INFO - Running setup.py (path:/tmp/pip-P2VtAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:42 INFO - Running setup.py (path:/tmp/pip-fpm6Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:42 INFO - Running setup.py (path:/tmp/pip-Oqo8Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:42 INFO - Running setup.py (path:/tmp/pip-FBykxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:42 INFO - Running setup.py (path:/tmp/pip-GAxCQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:42 INFO - Running setup.py install for manifestparser 09:01:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:42 INFO - Running setup.py install for mozcrash 09:01:42 INFO - Running setup.py install for mozdebug 09:01:43 INFO - Running setup.py install for mozdevice 09:01:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Running setup.py install for mozfile 09:01:43 INFO - Running setup.py install for mozhttpd 09:01:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Running setup.py install for mozinfo 09:01:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Running setup.py install for mozInstall 09:01:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Running setup.py install for mozleak 09:01:43 INFO - Running setup.py install for mozlog 09:01:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Running setup.py install for moznetwork 09:01:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:43 INFO - Running setup.py install for mozprocess 09:01:43 INFO - Running setup.py install for mozprofile 09:01:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:44 INFO - Running setup.py install for mozrunner 09:01:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:44 INFO - Running setup.py install for mozscreenshot 09:01:44 INFO - Running setup.py install for moztest 09:01:44 INFO - Running setup.py install for mozversion 09:01:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:44 INFO - Cleaning up... 09:01:44 INFO - Return code: 0 09:01:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:44 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')]} 09:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 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')]} 09:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:44 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 09:01:44 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 09:01:44 INFO - Using env: {'DISPLAY': ':0', 09:01:44 INFO - 'HOME': '/home/cltbld', 09:01:44 INFO - 'LANG': 'en_US.UTF-8', 09:01:44 INFO - 'LANGUAGE': 'en_US:en', 09:01:44 INFO - 'LOGNAME': 'cltbld', 09:01:44 INFO - 'MAIL': '/var/mail/cltbld', 09:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:44 INFO - 'MOZ_NO_REMOTE': '1', 09:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:44 INFO - 'NO_EM_RESTART': '1', 09:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:44 INFO - 'PWD': '/builds/slave/test', 09:01:44 INFO - 'SHELL': '/bin/bash', 09:01:44 INFO - 'SHLVL': '1', 09:01:44 INFO - 'TERM': 'linux', 09:01:44 INFO - 'TMOUT': '86400', 09:01:44 INFO - 'USER': 'cltbld', 09:01:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:44 INFO - '_': '/tools/buildbot/bin/python'} 09:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:44 INFO - Running setup.py (path:/tmp/pip-ln2WSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:44 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)) 09:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:44 INFO - Running setup.py (path:/tmp/pip-GJSYGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:44 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)) 09:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:44 INFO - Running setup.py (path:/tmp/pip-AavO42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:44 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)) 09:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:44 INFO - Running setup.py (path:/tmp/pip-s7G8gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:45 INFO - Running setup.py (path:/tmp/pip-x6dNnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:45 INFO - Running setup.py (path:/tmp/pip-01clxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:45 INFO - Running setup.py (path:/tmp/pip-GhKPhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:45 INFO - Running setup.py (path:/tmp/pip-BVuxmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:45 INFO - Running setup.py (path:/tmp/pip-5CrTrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:45 INFO - Running setup.py (path:/tmp/pip-mhz5fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:45 INFO - Running setup.py (path:/tmp/pip-n7Q53r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:45 INFO - Running setup.py (path:/tmp/pip-QlGSFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:45 INFO - Running setup.py (path:/tmp/pip-VwC9Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:45 INFO - Running setup.py (path:/tmp/pip-HrTGVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:45 INFO - Running setup.py (path:/tmp/pip-Ow4voy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:45 INFO - Running setup.py (path:/tmp/pip-5HosMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:45 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)) 09:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:45 INFO - Running setup.py (path:/tmp/pip-90lULN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:45 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)) 09:01:45 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)) 09:01:45 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)) 09:01:45 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)) 09:01:45 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)) 09:01:45 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)) 09:01:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:45 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 09:01:45 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 09:01:45 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 09:01:45 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 09:01:45 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 09:01:45 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 09:01:47 INFO - Downloading blessings-1.6.tar.gz 09:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:48 INFO - Installing collected packages: blessings 09:01:48 INFO - Running setup.py install for blessings 09:01:48 INFO - Successfully installed blessings 09:01:48 INFO - Cleaning up... 09:01:48 INFO - Return code: 0 09:01:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:48 INFO - Reading from file tmpfile_stdout 09:01:48 INFO - Current package versions: 09:01:48 INFO - argparse == 1.2.1 09:01:48 INFO - blessings == 1.6 09:01:48 INFO - blobuploader == 1.2.4 09:01:48 INFO - docopt == 0.6.1 09:01:48 INFO - functools32 == 3.2.3-2 09:01:48 INFO - jsonschema == 2.5.1 09:01:48 INFO - manifestparser == 1.1 09:01:48 INFO - mozInstall == 1.12 09:01:48 INFO - mozcrash == 0.17 09:01:48 INFO - mozdebug == 0.1 09:01:48 INFO - mozdevice == 0.48 09:01:48 INFO - mozfile == 1.2 09:01:48 INFO - mozhttpd == 0.7 09:01:48 INFO - mozinfo == 0.9 09:01:48 INFO - mozleak == 0.1 09:01:48 INFO - mozlog == 3.3 09:01:48 INFO - moznetwork == 0.27 09:01:48 INFO - mozprocess == 0.23 09:01:48 INFO - mozprofile == 0.28 09:01:48 INFO - mozrunner == 6.12 09:01:48 INFO - mozscreenshot == 0.1 09:01:48 INFO - mozsystemmonitor == 0.3 09:01:48 INFO - moztest == 0.7 09:01:48 INFO - mozversion == 1.4 09:01:48 INFO - psutil == 3.1.1 09:01:48 INFO - requests == 1.2.3 09:01:48 INFO - wsgiref == 0.1.2 09:01:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:48 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')]} 09:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:48 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')]} 09:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:48 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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:48 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 09:01:48 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 09:01:48 INFO - Using env: {'DISPLAY': ':0', 09:01:48 INFO - 'HOME': '/home/cltbld', 09:01:48 INFO - 'LANG': 'en_US.UTF-8', 09:01:48 INFO - 'LANGUAGE': 'en_US:en', 09:01:48 INFO - 'LOGNAME': 'cltbld', 09:01:48 INFO - 'MAIL': '/var/mail/cltbld', 09:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:48 INFO - 'MOZ_NO_REMOTE': '1', 09:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:48 INFO - 'NO_EM_RESTART': '1', 09:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:48 INFO - 'PWD': '/builds/slave/test', 09:01:48 INFO - 'SHELL': '/bin/bash', 09:01:48 INFO - 'SHLVL': '1', 09:01:48 INFO - 'TERM': 'linux', 09:01:48 INFO - 'TMOUT': '86400', 09:01:48 INFO - 'USER': 'cltbld', 09:01:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:48 INFO - '_': '/tools/buildbot/bin/python'} 09:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 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)) 09:01:48 INFO - Cleaning up... 09:01:48 INFO - Return code: 0 09:01:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01:48 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')]} 09:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:48 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')]} 09:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:48 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 0x29eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, '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': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', '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 09:01:48 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 09:01:48 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 09:01:48 INFO - Using env: {'DISPLAY': ':0', 09:01:48 INFO - 'HOME': '/home/cltbld', 09:01:48 INFO - 'LANG': 'en_US.UTF-8', 09:01:48 INFO - 'LANGUAGE': 'en_US:en', 09:01:48 INFO - 'LOGNAME': 'cltbld', 09:01:48 INFO - 'MAIL': '/var/mail/cltbld', 09:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:48 INFO - 'MOZ_NO_REMOTE': '1', 09:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:48 INFO - 'NO_EM_RESTART': '1', 09:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:48 INFO - 'PWD': '/builds/slave/test', 09:01:48 INFO - 'SHELL': '/bin/bash', 09:01:48 INFO - 'SHLVL': '1', 09:01:48 INFO - 'TERM': 'linux', 09:01:48 INFO - 'TMOUT': '86400', 09:01:48 INFO - 'USER': 'cltbld', 09:01:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:48 INFO - '_': '/tools/buildbot/bin/python'} 09:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:01:48 INFO - Cleaning up... 09:01:48 INFO - Return code: 0 09:01:48 INFO - Running post-action listener: _resource_record_post_action 09:01:48 INFO - Running post-action listener: _start_resource_monitoring 09:01:48 INFO - Starting resource monitoring. 09:01:48 INFO - [mozharness: 2016-07-28 16:01:48.850543Z] Finished create-virtualenv step (success) 09:01:48 INFO - [mozharness: 2016-07-28 16:01:48.850979Z] Running install step. 09:01:48 INFO - Running pre-action listener: _resource_record_pre_action 09:01:48 INFO - Running main action method: install 09:01:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:49 INFO - Reading from file tmpfile_stdout 09:01:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:49 INFO - Reading from file tmpfile_stdout 09:01:49 INFO - Output received: 09:01:49 INFO - Usage: mozinstall [options] installer 09:01:49 INFO - Options: 09:01:49 INFO - -h, --help show this help message and exit 09:01:49 INFO - -d DEST, --destination=DEST 09:01:49 INFO - Directory to install application into. [default: 09:01:49 INFO - "/builds/slave/test"] 09:01:49 INFO - --app=APP Application being installed. [default: firefox] 09:01:49 INFO - mkdir: /builds/slave/test/build/application 09:01:49 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'] 09:01:49 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 09:02:05 INFO - Reading from file tmpfile_stdout 09:02:05 INFO - Output received: 09:02:05 INFO - /builds/slave/test/build/application/firefox/firefox 09:02:05 INFO - Running post-action listener: _resource_record_post_action 09:02:05 INFO - [mozharness: 2016-07-28 16:02:05.569490Z] Finished install step (success) 09:02:05 INFO - [mozharness: 2016-07-28 16:02:05.569838Z] Running run-tests step. 09:02:05 INFO - Running pre-action listener: _resource_record_pre_action 09:02:05 INFO - Running main action method: run_tests 09:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:02:05 INFO - Python 2.7.3 09:02:05 INFO - Return code: 0 09:02:05 INFO - grabbing minidump binary from tooltool 09:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:05 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 0x2caa3b0>, '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 0x2cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cab740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:02:05 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 09:02:05 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 09:02:05 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 09:02:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:02:05 INFO - Return code: 0 09:02:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:02:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:02:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:02:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:02:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 09:02:05 INFO - Using env: {'DISPLAY': ':0', 09:02:05 INFO - 'HOME': '/home/cltbld', 09:02:05 INFO - 'LANG': 'en_US.UTF-8', 09:02:05 INFO - 'LANGUAGE': 'en_US:en', 09:02:05 INFO - 'LOGNAME': 'cltbld', 09:02:05 INFO - 'MAIL': '/var/mail/cltbld', 09:02:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:02:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:05 INFO - 'MOZ_NO_REMOTE': '1', 09:02:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:05 INFO - 'NO_EM_RESTART': '1', 09:02:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:05 INFO - 'PWD': '/builds/slave/test', 09:02:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:02:05 INFO - 'SHELL': '/bin/bash', 09:02:05 INFO - 'SHLVL': '1', 09:02:05 INFO - 'TERM': 'linux', 09:02:05 INFO - 'TMOUT': '86400', 09:02:05 INFO - 'USER': 'cltbld', 09:02:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582', 09:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:05 INFO - '_': '/tools/buildbot/bin/python'} 09:02:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:02:05 INFO - mozversion application_buildid: 20160728074632 09:02:05 INFO - mozversion application_changeset: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 09:02:05 INFO - mozversion application_display_name: Nightly 09:02:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:02:05 INFO - mozversion application_name: Firefox 09:02:05 INFO - mozversion application_remotingname: firefox 09:02:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:02:05 INFO - mozversion application_vendor: Mozilla 09:02:05 INFO - mozversion application_version: 50.0a1 09:02:05 INFO - mozversion platform_buildid: 20160728074632 09:02:05 INFO - mozversion platform_changeset: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 09:02:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:02:05 INFO - mozversion platform_version: 50.0a1 09:02:05 INFO - using testdate: 1469721725 09:02:05 INFO - actual date: 1469721725 09:02:05 INFO - starting webserver on 'localhost:37017' 09:02:05 INFO - SUITE-START | Running 2 tests 09:02:05 INFO - TEST-START | dromaeo_css 09:02:05 INFO - operating with platform_type : linux_ 09:02:05 INFO - Initialising browser for dromaeo_css test... 09:02:05 INFO - TEST-INFO | started process 31480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpolmOL1/profile http://localhost:37017/getInfo.html) 09:02:09 INFO - PROCESS | 31480 | JavaScript error: , line 0: uncaught exception: undefined 09:02:10 INFO - PROCESS | 31480 | __metrics Screen width/height:1600/1200 09:02:10 INFO - PROCESS | 31480 | colorDepth:24 09:02:10 INFO - PROCESS | 31480 | Browser inner width/height: 1024/697 09:02:10 INFO - PROCESS | 31480 | __metrics 09:02:11 INFO - PROCESS | 31480 | 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" 09:02:11 INFO - PROCESS | 31480 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:11 INFO - PROCESS | 31480 | console.error: PushService: 09:02:11 INFO - PROCESS | 31480 | stateChangeProcessEnqueue: Error transitioning state 09:02:11 INFO - PROCESS | 31480 | UnknownError 09:02:12 INFO - TEST-INFO | 31480: exit 0 09:02:12 INFO - Browser initialized. 09:02:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:02:12 INFO - TEST-INFO | started process 31558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpolmOL1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:24 INFO - PROCESS | 31558 | RSS: Main: 159358976 09:02:24 INFO - PROCESS | 31558 | 09:03:15 INFO - PROCESS | 31558 | 1469721795670 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] 09:05:27 INFO - PROCESS | 31558 | Cycle 1(1): loaded http://localhost:37017/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37017/tests/dromaeo/cssquery-ext.html) 09:05:28 INFO - PROCESS | 31558 | RSS: Main: 237752320 09:05:28 INFO - PROCESS | 31558 | 09:08:31 INFO - PROCESS | 31558 | Cycle 1(1): loaded http://localhost:37017/tests/dromaeo/cssquery-ext.html (next: http://localhost:37017/tests/dromaeo/cssquery-jquery.html) 09:08:32 INFO - PROCESS | 31558 | RSS: Main: 246575104 09:08:32 INFO - PROCESS | 31558 | 09:11:34 INFO - PROCESS | 31558 | Cycle 1(1): loaded http://localhost:37017/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37017/tests/dromaeo/cssquery-mootools.html) 09:11:34 INFO - PROCESS | 31558 | RSS: Main: 191119360 09:11:34 INFO - PROCESS | 31558 | 09:14:37 INFO - PROCESS | 31558 | Cycle 1(1): loaded http://localhost:37017/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37017/tests/dromaeo/cssquery-prototype.html) 09:14:37 INFO - PROCESS | 31558 | RSS: Main: 192126976 09:14:37 INFO - PROCESS | 31558 | 09:17:40 INFO - PROCESS | 31558 | Cycle 1(1): loaded http://localhost:37017/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37017/tests/dromaeo/cssquery-yui.html) 09:17:41 INFO - PROCESS | 31558 | RSS: Main: 191537152 09:17:41 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | Cycle 1(1): loaded http://localhost:37017/tests/dromaeo/cssquery-yui.html (next: http://localhost:37017/tests/dromaeo/cssquery-dojo.html) 09:20:44 INFO - PROCESS | 31558 | RSS: Main: 284094464 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | __start_tp_report 09:20:44 INFO - PROCESS | 31558 | _x_x_mozilla_page_load 09:20:44 INFO - PROCESS | 31558 | _x_x_mozilla_page_load_details 09:20:44 INFO - PROCESS | 31558 | |i|pagename|runs| 09:20:44 INFO - PROCESS | 31558 | |0;dojo.html;2596.1432727200026;2606.8696565171745;2616.3589920469476;2618.3977685132418;2641.7754490868274;4617.468991066028;4700.6944548604315;4750.643701722372;4761.023990082033;4794.544518270759;4619;4711.104890070884;4721.150192965273;4732.266498692699;4795.544423279792;4296.0978194579175;4300.6989510734265;4373.978130109345;4422.889427764299;4497.370368148446;4440.156370289651;4460.063386688799;4481.215787237236;4493.68544201906;4510.300903359985;4277.743335399886;4308.030693094061;4341.565843415665;4345.50026746925;4352.847650332224;4323.805428755713;4375.562443755599;4439.467263928317;4456.910861782779;4470.731756094645;4316.330968699856;4370.12597480502;4395.802188901507;4427;4436.3123715824095;4754.477007529169;4812.0375924814825;4842.201036828919;4849.418069831608;4857.6599638025355;4960.50394960501;4961.925571116436;5031.4465408805;5034.194528875362;5092.9236061459105;5072.923906141374;5083.440821509631;5123.1546794778815;5137.5633071188995;5141.15170996785;4586.036932244199;4750.14497390473;4759.333693282943;4759.785809638574;4768.117898188846;5212.4266330703595;5277.736113194325;5286.97356513215;5332.120200166929;5352.143657014937;5066.138756411346;5072.239164125411;5121.052605268037;5126.743662816844;5126.846194614168;4992.525710057539;5202.063628546898;5218.843434696889;5220.034293655686;5226.503482169188;4956.430010548761;4997.175466048134;5019.67372120811;5043.067032598981;5093.719845408464;5001;5003.924941125886;5003.949960500421;5021.472745361758;5065.265536497187;4200.348945913388;4303.117860838521;4309.892252693708;4313.3098704207805;4364.10535840152;3699.075231192202;3705.629437056327;3734.3838266686234;3777.58446570877;3791.298609757204;4357.193919124972;4364.672649551297;4365.672574556857;4378.978105109454;4409.338599210144;5072.6195535335;5074.568661663726;5076.289319495274;5080.415752188472;5115.028144652579;4267.509236437787;4275.978620106879;4294.6564274858565;4328.285832837547;4405.493368262691;4557.156925968707;4565.406497155349;4585.426821647294;4594.632429405639;4617.746023968714;4753.120672675566;4758.024604955906;4782.234842425195;4785.210440277455;4809.038192361541;4971.154903666457;5020.723860187579;5082.644214904921;5089.389273287081;5099.87250318745;4694.7417892016265;4709;4747.881302967316;4765.451973023147;4807.6394270429155;4984.352034235526;4987.925181122214;4989.226669866177;4989.792480130033;5038.874028149326;4874.976254986493;5050.924236136388;5053.494650534917;5054.4187418447345;5105.18317069282;4846.80612775485;4867.975660121677;4872.805087796449;4935.876603084952;4992;4894.2658601210105;4913.877153071202;4924.064427758714;4928.926066108939;4971.254311853251;4737.573618374363;4838.637102217277;4854.150523658275;4902.828401005948;4907.68100073494;4931.802727890844;4970.701757894538;4972.453030166606;4985.775640096277;5052.292679024866;4863.878403039952;4876.21980483121;4882.902341953212;4892.339534162842;4929.383827021622 09:20:44 INFO - PROCESS | 31558 | |1;ext.html;576.8211854325159;582.8950788858003;584.9473547380735;585.3882692586247;592.6414519215875;27537;30269.09192724219;30428.93498727548;42593.78703106488;44334;41179.17641647165;41672.166556668846;41761;41768.79115604418;41794.37308440376;7697.2302769722855;7820.843583128334;7827.491213071161;7836.451448398586;7845.137034926153;7383.48315617907;7876.80307992299;7968.083670377923;9850.507474626276;10156.746081347988;10236;10306.587736490532;10307.484625768719;10308.536115874766;10318.638847640334;10074.597016119347;10100.343477673965;10101.444420556867;10119.797604047877;10130.138938190263;9973.850392244121;10054.69835904924;10063.69808905734;10064.144547713453;10067.04363085513;38890.22219555593;39110.60889391127;39219;39227;39309.80345098256;2795.3291210109633;2831.065748303055;3032.438998785232;3078.8768449262;3261.1194977356217;29120.505539335205;29296;29470.557941630894;29506.262343441373;30185.69814301873;3269.362474317509;3351.581052368454;3382.830858457092;3413.197898493852;3452.723782097426;270870;276536;276563;277631;278113;56091;56426.71786641041;56539.15191272134;56560.717196414575;56795;32943.176420589676;34037;58639.70680146572;58670.11994820081;58687.41312586905;14278.07192532482;14617.634559136106;14624.707505849823;14632.268386580628;14635.634109147357;11006.779864402668;11205;11209.775804483865;11210.215284929976;11212.663620091247;16127.758083628754;17890.5527361817;18731.250749969848;18757.155927983273;19373.709394359095;6863.897041544381;6905.965470172617;7007.299270072952;7025.859482810315;7065.92934070663;847.3687103108224;861.2507118806678;907.6188001039579;929.9953500232456;940.5250348573926;28597;29195.41609167847;29326.26684332909;29744.851275743484;29800.40399192004;962.6582563190107;989.737719504332;1006.3509036671306;1027.7995790820867;1050.989490105089;14306.928465357814;15273.159976201194;15437.459688910834;15467.690646187013;15577.515145496167;406165;410335;411698;412109;412639;49598.75200624046;49717.75141124271;50046.499535004186;50070.499295007314;50169.49830501648;1069.2034434346463;1112.732944093428;1119.1158984402232;1185.549491193341;1187.074082215873;25509.744902550738;27269;29279.121626351243;29436.26409339698;30018;44357.556424435345;45149.54850451453;45168.77415612901;45178.322325165806;45268;370031;374347;374882;375488;375875;38533;39716.602833971294;40147;40645.39031914583;43153.56846431621;41199.1760164801;41514.79242603888;41886.79056604819;41900.58099419089;43202.13595728131;36088.4586731194;36356;36357;36503;36952.26095478021;36673.266534668626;36755.44866827053;37053;37268.44097338488;37750.811245943594;36463.453048203766;36673.81663091774;37041.25917481689;37143.44284835675;37556.81221593874;31651.841740791147;33457.49813752747;33532;33883.15292117717;34091.14772130716;25667;25760.871195644653;25796.871015645553;25845.870770646026;26003.869980649975 09:20:44 INFO - PROCESS | 31558 | |2;jquery.html;337.09153830426993;337.96789305016017;357.87653259625426;358.1154548265783;362.84216365880843;12822;16167.272472738725;16396.508104756846;17321.39375121871;18405.815941840578;16517.256723447445;16535;16549.25528351224;16702.7494587581;16748.83251167488;4922.114019476493;4962.851114466554;5067.315912351823;5096;5102.387713474388;3677.5586929568353;5053.090443720129;5122.129238029544;5133.563647090002;5614.66312021278;5888.32284287306;5962.493188078996;5973.104034394853;5982.940170598282;5994.580379373424;5730.4269573042775;5917.408259174092;5961.076033214858;5968.850778730523;6014.218151640259;5219.19102539107;5220.086484865134;5222.817201397933;5225.608079394061;5228.163493840967;20817.5836483271;21153.576928461345;21320;21339.893300533553;21803.781962180336;1841.3831366492107;2004.5690176611952;2244.5062086340977;2393.628987506939;2408.843425177358;12958;13163.670908227276;13226;14024;14031.298435078204;1700.6683696679152;1717.398910381369;1765.4438851761781;1767.9823201768074;1805.2057094878212;63078.68460657667;67027.32972670259;67231;67714;68152.97770533495;8892.688755893512;8936;9117.130988147414;9269.351145419756;9465.290103242285;11946.701332466584;11955.581554645545;11970.521179152911;11977;11983.16117871758;6833.555818871758;6966.338197871194;6970.825729356807;7107.289271072955;7123.643817809088;6735.865282694319;6751.527393082437;6906.102206713195;6926.826829329207;6928.861422771516;6037.758489660365;6043.033114701627;6237.96881015592;6254.405831446005;6264.467520260738;1644.4162322375623;1647.217571653479;1700.617361093744;1744.3807448355906;1759.4545690835882;829.5064436660177;846.3525403066659;862.9352798540135;909.231699214163;926.9351145419756;16894.49316520506;17900.641987160183;18254.36109736153;18557.35049273296;18647.44057678272;850.425962475339;868.9608967596473;873.8907636545432;897.7620930453435;935.1209862729013;9687.467189304656;10583.841242381217;10608.734781630521;10653.467326633638;10709;376040;380702;381839;388063;389565;67343.66328168426;69703.30296697069;70021.2997870025;71630;72082;867.3018220332567;913.712180663089;920.1120918313859;924.2421214604094;926.666400095965;15796.187230310803;15957.521274361789;16575.668486630442;16784.916075419544;16860;38914.2217155661;39460.60539394569;40033.599664002984;40046.799766000986;41295.1740965185;52309.47690523046;52734.208986866;53225.46774532205;54723.905521890134;54844.17733733918;7406.518576292524;7639.197884222299;7694.653740581799;7780.066392032766;7809.297163255334;8453.95773021131;11516;11904.76190476203;12166.844149805755;12178.695532611755;10331;10379.792404152025;10440.791184176425;10962.835557466804;10969.451527423438;10293.330933489598;10393.896061039293;10562.207834412604;10563.788724225626;10913;9896.20830333586;10332.276740628084;10752.13982881352;10798.892011080103;11219.66341009771;7386.778396648109;7552.886706699294;7625.504342217738;7642.273983971514;7772.68909243624;9787.657431989846;10156.136728378171;10315.17478601725;10587.89412105869;10905.291156074829 09:20:44 INFO - PROCESS | 31558 | |3;mootools.html;1230.3540641163393;1336.7727486327321;1368.452618952419;1421.7654087075632;1682.9663406731866;6605.339466053392;7323.890141647879;7590.620468976543;7613.162552119269;7836.8040798980055;7660.042494688164;7693.961530192341;7698.114716807569;7699.268569485904;7704.422168337369;2151.7095192149054;2170.4790850195996;2173.717416735822;2176.793204645556;2177.4556360909774;2108.11459187141;2144.957100857982;2150.731158605174;2154.709114269577;2155.892205389724;2094.52873103552;2111.5354621983215;2130.6164890319737;2136.295022642524;2147.6241657709916;2099.77952315007;2104.6842973553935;2106.441792924876;2108.1040557762967;2108.388567315477;2033.1257559249516;2116.544942837282;2117.333040092366;2117.3965419855267;2121.278765219817;7573.394128469709;7654.043244594426;7682.193369696213;7734.110577283628;7734.419918506078;4296.484421869396;4427.535108813592;4435.756033418161;4494.011317510142;4495.910081798378;2754.6832114306912;2867.7562407195414;2880.135959212249;2882.409106133238;2902.1148549692334;908.8682141089571;914.8033172867865;920.9631614735403;925.5464822237122;932.4638332958576;10311;10368.948155259252;10409.479526023744;10418.947905260426;10425.687229383131;3694.8891533254045;3944.6449819516383;4018.738781979162;4040.676745860324;4054.2499637567144;7991.8811366408745;7996.9200307997335;7996.960015199887;8000.239977202156;8012;4428.424304840414;4444.444444444444;4449.154660614473;4450.755208463501;4454.576815202616;3553.804540750232;3634.6910512606196;3897.2205558888336;4118.9588104118575;4120.320147175742;3208.2941752814345;3236.5954255718034;3340.8997730068136;3359.311341175102;3361.075704181321;942.4062840410497;983.9852402213972;984.07988530724;997.9201663866874;1003.4731765823001;736.7126820539994;782.0732432068017;782.9177936316719;789.9170587088273;802.967881284742;5154.5103215194495;5197.792088316501;5249.973750131225;5277.883251064176;5433.320834895638;389.5072732992766;393.30188914676677;406.69497876592555;410.4622943943444;414.4756882543585;3551.360755064113;3682.2819550187455;3688.870889518854;3698.001539584297;3726.087108658396;9232.676856309998;9700.078492543196;9718.465484398426;9739.220862330996;9742.07450292221;8922.420042697204;9177.587008584629;9586.616535338508;9595.13643772064;9605.37565058269;7132.893006604905;7356.632168391559;7364.594947277951;7376.225496322809;7377.077865266841;5348.7593058311695;5422.810201642924;5456.454354564512;5532.004239236976;5581.906784955641;8437.746867593982;8590.055093939787;8632.91367086321;8697.304215662858;8866.911330886609;8853.778655533662;8854.822903541764;8966.506842123747;9021.503817290111;9075.364724469224;5810.215620891295;6584.176977877765;6727.764528241488;6730.125083739083;6731.596104233566;6651.567648102858;6815.114035175396;6886.414654754402;6893.620850853251;7193.244709305657;6616.735330586916;6650.600963942179;6756.493263005393;6841.521093523605;6925.896111558432;6595.208574971034;6598.340165983555;6600.669966501559;6602.735890564516;6698.56459330142;6004.39956004396;6101.450869421773;6106.480949119375;6107.206063211754;6107.572469927062;4501.2347900857585;4650.767461626972;4656.906861862812;4713.9292910607055;4775.976120119377;4588.334691469785;4595.862124136282;4637.744924029076;4709.105269998689;4950.727709975986 09:20:44 INFO - PROCESS | 31558 | |4;prototype.html;280.493708855516;285.43723115940224;294.7067667670668;295.2338681122486;301.78422427964;4556.225441674915;4731;4750.859793649525;4761.90476190476;4773.140834649766;4515.412996310483;4679.27471241958;4704.776758042908;4714.104320179172;4739.289106634006;3736.7481893565687;3746.4193050077283;3751.493548370969;3756.7370284080125;3761.2289480656536;3574.1422058705853;3757.66181043706;3760.2291530236234;3763.56718977317;3765.811709414532;3514.9648503514895;3703.7962912039825;3718.9628103718887;3729.7948612826285;3740.625937406251;3709.202521457886;3717.345781127386;3733.6453036961443;3735.8879233623034;3747.2130852521004;3278.1149089745873;3281.6390197078304;3284.7372210223366;3287.917802054944;3295.8794010036463;4495.370648109268;4596;4634.976825115887;4640.839790052487;4666.136764698507;4238.512571054337;4244.787760611957;4246.108317253381;4251.59609837065;4282.443282373302;4956.7199088419375;4973.477784832577;4976.934572152552;4978.626603004789;4979.800807967713;3351.916202094967;3496.143444856001;3507.789532628025;3508.8771892983877;3612.1330880588735;5137.691738495702;5163.509466600667;5168.534831865112;5181.171012637959;5200.323957885488;3593.82030898454;3597.5503062117236;3610;3617.385044542434;3623.221007483404;3453.9481907771406;3652.1782598915033;3675.320065787784;3689.741718079709;3696.094456858087;4148.605882441163;4150.315197992298;4164.333706606928;4173.728707633994;4173.791310434466;4946.505349465025;4947.65366424354;4948.901021979612;4959.776810043557;4972.825951091694;1199.9100067494974;1220.170284206748;1235.116891422637;1246.9127161098636;1252.4614415801293;845.1421806866036;862.4911302331654;865.6061492021115;869.5391442535466;872.7469033980202;4373.803178856959;4377.430933978562;4381.715188512737;4384.298512238091;4403.361512580658;5068.290439338495;5105.897882042413;5106.795728170831;5113.386393632788;5121.489160697603;4246.747209573184;4360.345948107809;4459.996500787362;4475.395821564047;4480.372747815309;2697.5953606959115;2723.6595425571804;2724.741149590786;2725.1552018874213;2748.670159580863;4804.045512010089;4848.17581011229;4850.805967761321;4854.271859221145;4857.611391088704;5083.644144909895;5228.784297656914;5250.579953603703;5251.76367063483;5253.632245742761;4812.133815913099;4848.418189817104;4893.804247830119;4896.804127834918;4905.3623029006;5038.603005394839;5117.181250999822;5121.436641969306;5141.305923700253;5170.6380553360905;5001.824936127364;5007.624428167829;5027.673201241908;5028.522290382408;5039.496050395078;4853.126437241331;4855.854324370133;4869.926951095807;4873.756312184448;4901.362822833009;3593.568771747407;3599.478075679064;3615.132368231658;3615.427289129237;3620.7103431725927;5004.47453017428;5031.496850315086;5112.696262453051;5156.1492353761205;5160.767765450639;4999;5005.099082165245;5013.523715247045;5020.272060551127;5020.824271150492;4928.260760885896;4953.9752301239705;4963.205887058053;4989.326440930573;5056.469070747518;4651.2557990721325;4652.185867473247;4743.217369134054;4901.142300097397;4914.8771280718265;4995.300657907823;5003;5010.423801262901;5011.949880501148;5024.42219144803;4894.779734912009;4911.287863259879;4926.48271931442;4935.506449355035;4943.209086546135 09:20:44 INFO - PROCESS | 31558 | |5;yui.html;587.9063506752511;631.8925782616955;632.6393955445398;723.7286017743346;724.9452047271221;11399.202055856093;12072.396380180979;12106.576269830557;12125.454354554044;12130.939345303283;13013.80479292809;13220.867791322084;13255.93372033141;13264.933675331635;13269.601911942656;615.7752420366579;747.0325927923338;756.0662581711582;768.5427170833373;772.1236396689769;764.9961750191242;776.9689212431496;777.4169372970272;778.0857492446381;778.1168373895613;819.7622689420061;825.8100636853527;826.4256341842422;826.7850358906697;827.5903427803246;651.1144843013498;786.4337676872642;807.4953154278576;822.8518866604009;823.1521532821174;591.6361437715774;595.0508938243495;595.1845971019687;595.3421469276431;595.5295316699802;12309.507619695201;12347.135700500969;12350.0737444692;12360.814587781191;12378.195417297937;11508.424578771112;11721.648350549498;11771.470283837161;11797.528098876035;12777.680557986032;9732.854007189897;10007.549660265306;11887.762244755142;11890.583829565923;11890.643280701594;4118.794060296973;4125.64931980782;4180.331147016463;4217.936730949038;4328.307470804688;65693.99999999952;65893.3410665892;67029;67188.3281167187;67198.3280167197;9207.907920920705;9215.90784092164;9381.90618093824;9540.522973851279;9619.51902404877;17046.318147274218;17306.913465432594;17444.825551744572;17456.127193640266;18092.366767163086;6440.774572889926;6492.740290388426;6520.282768895418;6535.444487218545;6668.433183179484;3632.4914511968345;3636.781793092423;3657.8719744808805;3676.9632303677154;3682.226732386229;2703.297142742901;2805.5230610796216;2832.5326321156776;2836.1208025512155;2850.2589326775187;509.1802198460476;512.101262284688;514.8095204774182;515.7498613172609;520.4795204795205;551.8537587539305;592.4312659846596;600.1747597054051;603.3003496175002;611.5291225756143;7910;8035.879461808077;8080.9191908080165;8175.182481751896;8373.748787536384;461.88914660481913;507.66747780204025;519.5194445138231;566.4816692726192;576.8932747441737;3751.868684596026;3820.6179382061573;3904.375299951994;3970.781607011642;4089.1821635672986;80601.59699201466;81423.59288203639;97444.51277743567;100937;101432.49283753682;91405.54297228472;93603;93659.53170234241;93781.53109234547;94359.52820235855;77609.61195194101;78987;80076;80973;81287;8159.184081591793;8766.167214114648;8834.823303534022;8909.420887642542;9034.27725781949;45470.31794523151;46306;46557.53442465532;47159;48003.5199647999;37309.81345093366;38932.221355573296;42911.57088429201;43019.78490107655;44517;10411.687649370531;10781.029707326064;10832.458377081271;10858.67423977282;11392;13239.801402979156;13487.393067311797;13547.729045418839;13640.590782276548;14074.749679779557;11462.598809041643;11745.47145378443;11799.410029498662;12194.146409751233;12209.38953052326;10818.729531761453;11263.7747245053;12605.495780169058;12607;12625;12013.629532637844;12214.633560993185;12549.120915698237;12681.8097728536;12938.223706577635;10027.799444010932;10222.642207522998;10307.433091180057;10394.844077338998;10633.415162166155;8884.045509987793;9416.293777966543;10118.139958103644;10367.377957322586;10452.425116618659 09:20:44 INFO - PROCESS | 31558 | __end_tp_report 09:20:44 INFO - PROCESS | 31558 | __start_cc_report 09:20:44 INFO - PROCESS | 31558 | _x_x_mozilla_cycle_collect,1113 09:20:44 INFO - PROCESS | 31558 | __end_cc_report 09:20:44 INFO - PROCESS | 31558 | __startTimestamp1469722844586__endTimestamp 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | ------- Summary: start ------- 09:20:44 INFO - PROCESS | 31558 | Number of tests: 6 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | [#0] dojo.html Cycles:165 Average:4693.05 Median:4812.04 stddev:498.98 (10.4%) stddev-sans-first:472.62 09:20:44 INFO - PROCESS | 31558 | Values: 2596.1 2606.9 2616.4 2618.4 2641.8 4617.5 4700.7 4750.6 4761.0 4794.5 4619.0 4711.1 4721.2 4732.3 4795.5 4296.1 4300.7 4374.0 4422.9 4497.4 4440.2 4460.1 4481.2 4493.7 4510.3 4277.7 4308.0 4341.6 4345.5 4352.8 4323.8 4375.6 4439.5 4456.9 4470.7 4316.3 4370.1 4395.8 4427.0 4436.3 4754.5 4812.0 4842.2 4849.4 4857.7 4960.5 4961.9 5031.4 5034.2 5092.9 5072.9 5083.4 5123.2 5137.6 5141.2 4586.0 4750.1 4759.3 4759.8 4768.1 5212.4 5277.7 5287.0 5332.1 5352.1 5066.1 5072.2 5121.1 5126.7 5126.8 4992.5 5202.1 5218.8 5220.0 5226.5 4956.4 4997.2 5019.7 5043.1 5093.7 5001.0 5003.9 5003.9 5021.5 5065.3 4200.3 4303.1 4309.9 4313.3 4364.1 3699.1 3705.6 3734.4 3777.6 3791.3 4357.2 4364.7 4365.7 4379.0 4409.3 5072.6 5074.6 5076.3 5080.4 5115.0 4267.5 4276.0 4294.7 4328.3 4405.5 4557.2 4565.4 4585.4 4594.6 4617.7 4753.1 4758.0 4782.2 4785.2 4809.0 4971.2 5020.7 5082.6 5089.4 5099.9 4694.7 4709.0 4747.9 4765.5 4807.6 4984.4 4987.9 4989.2 4989.8 5038.9 4875.0 5050.9 5053.5 5054.4 5105.2 4846.8 4868.0 4872.8 4935.9 4992.0 4894.3 4913.9 4924.1 4928.9 4971.3 4737.6 4838.6 4854.2 4902.8 4907.7 4931.8 4970.7 4972.5 4985.8 5052.3 4863.9 4876.2 4882.9 4892.3 4929.4 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | [#1] ext.html Cycles:180 Average:51074.43 Median:36410.23 stddev:94362.29 (259.2%) stddev-sans-first:94550.83 09:20:44 INFO - PROCESS | 31558 | Values: 576.8 582.9 584.9 585.4 592.6 27537.0 30269.1 30428.9 42593.8 44334.0 41179.2 41672.2 41761.0 41768.8 41794.4 7697.2 7820.8 7827.5 7836.5 7845.1 7383.5 7876.8 7968.1 9850.5 10156.7 10236.0 10306.6 10307.5 10308.5 10318.6 10074.6 10100.3 10101.4 10119.8 10130.1 9973.9 10054.7 10063.7 10064.1 10067.0 38890.2 39110.6 39219.0 39227.0 39309.8 2795.3 2831.1 3032.4 3078.9 3261.1 29120.5 29296.0 29470.6 29506.3 30185.7 3269.4 3351.6 3382.8 3413.2 3452.7 270870.0 276536.0 276563.0 277631.0 278113.0 56091.0 56426.7 56539.2 56560.7 56795.0 32943.2 34037.0 58639.7 58670.1 58687.4 14278.1 14617.6 14624.7 14632.3 14635.6 11006.8 11205.0 11209.8 11210.2 11212.7 16127.8 17890.6 18731.3 18757.2 19373.7 6863.9 6906.0 7007.3 7025.9 7065.9 847.4 861.3 907.6 930.0 940.5 28597.0 29195.4 29326.3 29744.9 29800.4 962.7 989.7 1006.4 1027.8 1051.0 14306.9 15273.2 15437.5 15467.7 15577.5 406165.0 410335.0 411698.0 412109.0 412639.0 49598.8 49717.8 50046.5 50070.5 50169.5 1069.2 1112.7 1119.1 1185.5 1187.1 25509.7 27269.0 29279.1 29436.3 30018.0 44357.6 45149.5 45168.8 45178.3 45268.0 370031.0 374347.0 374882.0 375488.0 375875.0 38533.0 39716.6 40147.0 40645.4 43153.6 41199.2 41514.8 41886.8 41900.6 43202.1 36088.5 36356.0 36357.0 36503.0 36952.3 36673.3 36755.4 37053.0 37268.4 37750.8 36463.5 36673.8 37041.3 37143.4 37556.8 31651.8 33457.5 33532.0 33883.2 34091.1 25667.0 25760.9 25796.9 25845.9 26003.9 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | [#2] jquery.html Cycles:180 Average:24208.13 Median:40670.99 stddev:63141.86 (155.3%) stddev-sans-first:63293.55 09:20:44 INFO - PROCESS | 31558 | Values: 337.1 338.0 357.9 358.1 362.8 12822.0 16167.3 16396.5 17321.4 18405.8 16517.3 16535.0 16549.3 16702.7 16748.8 4922.1 4962.9 5067.3 5096.0 5102.4 3677.6 5053.1 5122.1 5133.6 5614.7 5888.3 5962.5 5973.1 5982.9 5994.6 5730.4 5917.4 5961.1 5968.9 6014.2 5219.2 5220.1 5222.8 5225.6 5228.2 20817.6 21153.6 21320.0 21339.9 21803.8 1841.4 2004.6 2244.5 2393.6 2408.8 12958.0 13163.7 13226.0 14024.0 14031.3 1700.7 1717.4 1765.4 1768.0 1805.2 63078.7 67027.3 67231.0 67714.0 68153.0 8892.7 8936.0 9117.1 9269.4 9465.3 11946.7 11955.6 11970.5 11977.0 11983.2 6833.6 6966.3 6970.8 7107.3 7123.6 6735.9 6751.5 6906.1 6926.8 6928.9 6037.8 6043.0 6238.0 6254.4 6264.5 1644.4 1647.2 1700.6 1744.4 1759.5 829.5 846.4 862.9 909.2 926.9 16894.5 17900.6 18254.4 18557.4 18647.4 850.4 869.0 873.9 897.8 935.1 9687.5 10583.8 10608.7 10653.5 10709.0 376040.0 380702.0 381839.0 388063.0 389565.0 67343.7 69703.3 70021.3 71630.0 72082.0 867.3 913.7 920.1 924.2 926.7 15796.2 15957.5 16575.7 16784.9 16860.0 38914.2 39460.6 40033.6 40046.8 41295.2 52309.5 52734.2 53225.5 54723.9 54844.2 7406.5 7639.2 7694.7 7780.1 7809.3 8454.0 11516.0 11904.8 12166.8 12178.7 10331.0 10379.8 10440.8 10962.8 10969.5 10293.3 10393.9 10562.2 10563.8 10913.0 9896.2 10332.3 10752.1 10798.9 11219.7 7386.8 7552.9 7625.5 7642.3 7772.7 9787.7 10156.1 10315.2 10587.9 10905.3 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | [#3] mootools.html Cycles:180 Average:4991.17 Median:5385.78 stddev:2821.90 (52.4%) stddev-sans-first:2815.67 09:20:44 INFO - PROCESS | 31558 | Values: 1230.4 1336.8 1368.5 1421.8 1683.0 6605.3 7323.9 7590.6 7613.2 7836.8 7660.0 7694.0 7698.1 7699.3 7704.4 2151.7 2170.5 2173.7 2176.8 2177.5 2108.1 2145.0 2150.7 2154.7 2155.9 2094.5 2111.5 2130.6 2136.3 2147.6 2099.8 2104.7 2106.4 2108.1 2108.4 2033.1 2116.5 2117.3 2117.4 2121.3 7573.4 7654.0 7682.2 7734.1 7734.4 4296.5 4427.5 4435.8 4494.0 4495.9 2754.7 2867.8 2880.1 2882.4 2902.1 908.9 914.8 921.0 925.5 932.5 10311.0 10368.9 10409.5 10418.9 10425.7 3694.9 3944.6 4018.7 4040.7 4054.2 7991.9 7996.9 7997.0 8000.2 8012.0 4428.4 4444.4 4449.2 4450.8 4454.6 3553.8 3634.7 3897.2 4119.0 4120.3 3208.3 3236.6 3340.9 3359.3 3361.1 942.4 984.0 984.1 997.9 1003.5 736.7 782.1 782.9 789.9 803.0 5154.5 5197.8 5250.0 5277.9 5433.3 389.5 393.3 406.7 410.5 414.5 3551.4 3682.3 3688.9 3698.0 3726.1 9232.7 9700.1 9718.5 9739.2 9742.1 8922.4 9177.6 9586.6 9595.1 9605.4 7132.9 7356.6 7364.6 7376.2 7377.1 5348.8 5422.8 5456.5 5532.0 5581.9 8437.7 8590.1 8632.9 8697.3 8866.9 8853.8 8854.8 8966.5 9021.5 9075.4 5810.2 6584.2 6727.8 6730.1 6731.6 6651.6 6815.1 6886.4 6893.6 7193.2 6616.7 6650.6 6756.5 6841.5 6925.9 6595.2 6598.3 6600.7 6602.7 6698.6 6004.4 6101.5 6106.5 6107.2 6107.6 4501.2 4650.8 4656.9 4713.9 4776.0 4588.3 4595.9 4637.7 4709.1 4950.7 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | [#4] prototype.html Cycles:180 Average:4131.89 Median:4709.44 stddev:1201.43 (25.5%) stddev-sans-first:1169.50 09:20:44 INFO - PROCESS | 31558 | Values: 280.5 285.4 294.7 295.2 301.8 4556.2 4731.0 4750.9 4761.9 4773.1 4515.4 4679.3 4704.8 4714.1 4739.3 3736.7 3746.4 3751.5 3756.7 3761.2 3574.1 3757.7 3760.2 3763.6 3765.8 3515.0 3703.8 3719.0 3729.8 3740.6 3709.2 3717.3 3733.6 3735.9 3747.2 3278.1 3281.6 3284.7 3287.9 3295.9 4495.4 4596.0 4635.0 4640.8 4666.1 4238.5 4244.8 4246.1 4251.6 4282.4 4956.7 4973.5 4976.9 4978.6 4979.8 3351.9 3496.1 3507.8 3508.9 3612.1 5137.7 5163.5 5168.5 5181.2 5200.3 3593.8 3597.6 3610.0 3617.4 3623.2 3453.9 3652.2 3675.3 3689.7 3696.1 4148.6 4150.3 4164.3 4173.7 4173.8 4946.5 4947.7 4948.9 4959.8 4972.8 1199.9 1220.2 1235.1 1246.9 1252.5 845.1 862.5 865.6 869.5 872.7 4373.8 4377.4 4381.7 4384.3 4403.4 5068.3 5105.9 5106.8 5113.4 5121.5 4246.7 4360.3 4460.0 4475.4 4480.4 2697.6 2723.7 2724.7 2725.2 2748.7 4804.0 4848.2 4850.8 4854.3 4857.6 5083.6 5228.8 5250.6 5251.8 5253.6 4812.1 4848.4 4893.8 4896.8 4905.4 5038.6 5117.2 5121.4 5141.3 5170.6 5001.8 5007.6 5027.7 5028.5 5039.5 4853.1 4855.9 4869.9 4873.8 4901.4 3593.6 3599.5 3615.1 3615.4 3620.7 5004.5 5031.5 5112.7 5156.1 5160.8 4999.0 5005.1 5013.5 5020.3 5020.8 4928.3 4954.0 4963.2 4989.3 5056.5 4651.3 4652.2 4743.2 4901.1 4914.9 4995.3 5003.0 5010.4 5011.9 5024.4 4894.8 4911.3 4926.5 4935.5 4943.2 09:20:44 INFO - PROCESS | 31558 | 09:20:44 INFO - PROCESS | 31558 | [#5] yui.html Cycles:180 Average:17568.02 Median:23383.94 stddev:25483.62 (109.0%) stddev-sans-first:25523.21 09:20:44 INFO - PROCESS | 31558 | Values: 587.9 631.9 632.6 723.7 724.9 11399.2 12072.4 12106.6 12125.5 12130.9 13013.8 13220.9 13255.9 13264.9 13269.6 615.8 747.0 756.1 768.5 772.1 765.0 777.0 777.4 778.1 778.1 819.8 825.8 826.4 826.8 827.6 651.1 786.4 807.5 822.9 823.2 591.6 595.1 595.2 595.3 595.5 12309.5 12347.1 12350.1 12360.8 12378.2 11508.4 11721.6 11771.5 11797.5 12777.7 9732.9 10007.5 11887.8 11890.6 11890.6 4118.8 4125.6 4180.3 4217.9 4328.3 65694.0 65893.3 67029.0 67188.3 67198.3 9207.9 9215.9 9381.9 9540.5 9619.5 17046.3 17306.9 17444.8 17456.1 18092.4 6440.8 6492.7 6520.3 6535.4 6668.4 3632.5 3636.8 3657.9 3677.0 3682.2 2703.3 2805.5 2832.5 2836.1 2850.3 509.2 512.1 514.8 515.7 520.5 551.9 592.4 600.2 603.3 611.5 7910.0 8035.9 8080.9 8175.2 8373.7 461.9 507.7 519.5 566.5 576.9 3751.9 3820.6 3904.4 3970.8 4089.2 80601.6 81423.6 97444.5 100937.0 101432.5 91405.5 93603.0 93659.5 93781.5 94359.5 77609.6 78987.0 80076.0 80973.0 81287.0 8159.2 8766.2 8834.8 8909.4 9034.3 45470.3 46306.0 46557.5 47159.0 48003.5 37309.8 38932.2 42911.6 43019.8 44517.0 10411.7 10781.0 10832.5 10858.7 11392.0 13239.8 13487.4 13547.7 13640.6 14074.7 11462.6 11745.5 11799.4 12194.1 12209.4 10818.7 11263.8 12605.5 12607.0 12625.0 12013.6 12214.6 12549.1 12681.8 12938.2 10027.8 10222.6 10307.4 10394.8 10633.4 8884.0 9416.3 10118.1 10367.4 10452.4 09:20:44 INFO - PROCESS | 31558 | -------- Summary: end -------- 09:20:44 INFO - PROCESS | 31558 | 09:20:45 INFO - TEST-INFO | 31558: exit 0 09:20:45 INFO - TEST-OK | dromaeo_css | took 1119584ms 09:20:45 INFO - TEST-START | kraken 09:20:45 INFO - operating with platform_type : linux_ 09:20:45 INFO - Initialising browser for kraken test... 09:20:45 INFO - TEST-INFO | started process 31752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkMkSbQ/profile http://localhost:37017/getInfo.html) 09:20:48 INFO - PROCESS | 31752 | JavaScript error: , line 0: uncaught exception: undefined 09:20:49 INFO - PROCESS | 31752 | __metrics Screen width/height:1600/1200 09:20:49 INFO - PROCESS | 31752 | colorDepth:24 09:20:49 INFO - PROCESS | 31752 | Browser inner width/height: 1024/697 09:20:49 INFO - PROCESS | 31752 | __metrics 09:20:50 INFO - PROCESS | 31752 | 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" 09:20:50 INFO - PROCESS | 31752 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:20:51 INFO - TEST-INFO | 31752: exit 0 09:20:51 INFO - Browser initialized. 09:20:51 INFO - Running cycle 1/1 for kraken test... 09:20:51 INFO - TEST-INFO | started process 31833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkMkSbQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:03 INFO - PROCESS | 31833 | RSS: Main: 159227904 09:21:03 INFO - PROCESS | 31833 | 09:21:06 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37017/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:07 INFO - PROCESS | 31833 | RSS: Main: 215273472 09:21:07 INFO - PROCESS | 31833 | 09:21:09 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37017/tests/kraken/driver.html?testName=audio-dft) 09:21:10 INFO - PROCESS | 31833 | RSS: Main: 192839680 09:21:10 INFO - PROCESS | 31833 | 09:21:13 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37017/tests/kraken/driver.html?testName=audio-fft) 09:21:14 INFO - PROCESS | 31833 | RSS: Main: 271314944 09:21:14 INFO - PROCESS | 31833 | 09:21:16 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37017/tests/kraken/driver.html?testName=audio-oscillator) 09:21:17 INFO - PROCESS | 31833 | RSS: Main: 182063104 09:21:17 INFO - PROCESS | 31833 | 09:21:19 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37017/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:19 INFO - PROCESS | 31833 | RSS: Main: 186630144 09:21:19 INFO - PROCESS | 31833 | 09:21:23 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37017/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:23 INFO - PROCESS | 31833 | RSS: Main: 223174656 09:21:23 INFO - PROCESS | 31833 | 09:21:27 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37017/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:27 INFO - PROCESS | 31833 | RSS: Main: 216526848 09:21:27 INFO - PROCESS | 31833 | 09:21:30 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37017/tests/kraken/driver.html?testName=json-parse-financial) 09:21:31 INFO - PROCESS | 31833 | RSS: Main: 219881472 09:21:31 INFO - PROCESS | 31833 | 09:21:33 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37017/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:33 INFO - PROCESS | 31833 | RSS: Main: 186085376 09:21:33 INFO - PROCESS | 31833 | 09:21:35 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:36 INFO - PROCESS | 31833 | RSS: Main: 191483904 09:21:36 INFO - PROCESS | 31833 | 09:21:38 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:39 INFO - PROCESS | 31833 | RSS: Main: 196059136 09:21:39 INFO - PROCESS | 31833 | 09:21:41 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:42 INFO - PROCESS | 31833 | RSS: Main: 191172608 09:21:42 INFO - PROCESS | 31833 | 09:21:45 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:45 INFO - PROCESS | 31833 | RSS: Main: 193720320 09:21:45 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | Cycle 1(1): loaded http://localhost:37017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37017/tests/kraken/driver.html?testName=ai-astar) 09:21:47 INFO - PROCESS | 31833 | RSS: Main: 245284864 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | __start_tp_report 09:21:47 INFO - PROCESS | 31833 | _x_x_mozilla_page_load 09:21:47 INFO - PROCESS | 31833 | _x_x_mozilla_page_load_details 09:21:47 INFO - PROCESS | 31833 | |i|pagename|runs| 09:21:47 INFO - PROCESS | 31833 | |0;ai-astar;104;115;115;113;113;114;115;114;115;115 09:21:47 INFO - PROCESS | 31833 | |1;audio-beat-detection;155;125;124;192;127;129;147;127;165;121 09:21:47 INFO - PROCESS | 31833 | |2;audio-dft;161;162;160;161;162;160;161;161;161;162 09:21:47 INFO - PROCESS | 31833 | |3;audio-fft;75;76;76;128;78;76;75;76;102;75 09:21:47 INFO - PROCESS | 31833 | |4;audio-oscillator;85;86;121;86;86;86;131;86;86;121 09:21:47 INFO - PROCESS | 31833 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;117;117;117 09:21:47 INFO - PROCESS | 31833 | |6;imaging-darkroom;146;147;147;145;148;147;147;147;147;147 09:21:47 INFO - PROCESS | 31833 | |7;imaging-desaturate;95;95;95;97;95;96;95;96;95;95 09:21:47 INFO - PROCESS | 31833 | |8;json-parse-financial;64;62;62;62;62;63;62;62;61;60 09:21:47 INFO - PROCESS | 31833 | |9;json-stringify-tinderbox;66;66;66;65;66;66;66;65;66;67 09:21:47 INFO - PROCESS | 31833 | |10;stanford-crypto-aes;80;81;80;79;80;80;80;79;80;84 09:21:47 INFO - PROCESS | 31833 | |11;stanford-crypto-ccm;142;131;130;130;130;130;127;136;175;129 09:21:47 INFO - PROCESS | 31833 | |12;stanford-crypto-pbkdf2;171;166;166;165;177;170;171;168;168;174 09:21:47 INFO - PROCESS | 31833 | |13;stanford-crypto-sha256-iterative;69;68;68;69;68;71;68;67;71;66 09:21:47 INFO - PROCESS | 31833 | __end_tp_report 09:21:47 INFO - PROCESS | 31833 | __start_cc_report 09:21:47 INFO - PROCESS | 31833 | _x_x_mozilla_cycle_collect,1949 09:21:47 INFO - PROCESS | 31833 | __end_cc_report 09:21:47 INFO - PROCESS | 31833 | __startTimestamp1469722907944__endTimestamp 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | ------- Summary: start ------- 09:21:47 INFO - PROCESS | 31833 | Number of tests: 14 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.37 (2.9%) stddev-sans-first:0.87 09:21:47 INFO - PROCESS | 31833 | Values: 104.0 115.0 115.0 113.0 113.0 114.0 115.0 114.0 115.0 115.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:138.00 stddev:23.31 (16.9%) stddev-sans-first:24.18 09:21:47 INFO - PROCESS | 31833 | Values: 155.0 125.0 124.0 192.0 127.0 129.0 147.0 127.0 165.0 121.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:21:47 INFO - PROCESS | 31833 | Values: 161.0 162.0 160.0 161.0 162.0 160.0 161.0 161.0 161.0 162.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:17.62 (23.2%) stddev-sans-first:18.41 09:21:47 INFO - PROCESS | 31833 | Values: 75.0 76.0 76.0 128.0 78.0 76.0 75.0 76.0 102.0 75.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:86.00 stddev:18.79 (21.8%) stddev-sans-first:19.38 09:21:47 INFO - PROCESS | 31833 | Values: 85.0 86.0 121.0 86.0 86.0 86.0 131.0 86.0 86.0 121.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 09:21:47 INFO - PROCESS | 31833 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 09:21:47 INFO - PROCESS | 31833 | Values: 146.0 147.0 147.0 145.0 148.0 147.0 147.0 147.0 147.0 147.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 09:21:47 INFO - PROCESS | 31833 | Values: 95.0 95.0 95.0 97.0 95.0 96.0 95.0 96.0 95.0 95.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:1.05 (1.7%) stddev-sans-first:0.83 09:21:47 INFO - PROCESS | 31833 | Values: 64.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 61.0 60.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:21:47 INFO - PROCESS | 31833 | Values: 66.0 66.0 66.0 65.0 66.0 66.0 66.0 65.0 66.0 67.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:1.42 (1.8%) stddev-sans-first:1.50 09:21:47 INFO - PROCESS | 31833 | Values: 80.0 81.0 80.0 79.0 80.0 80.0 80.0 79.0 80.0 84.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:130.50 stddev:14.36 (11.0%) stddev-sans-first:15.07 09:21:47 INFO - PROCESS | 31833 | Values: 142.0 131.0 130.0 130.0 130.0 130.0 127.0 136.0 175.0 129.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.50 stddev:3.81 (2.2%) stddev-sans-first:4.00 09:21:47 INFO - PROCESS | 31833 | Values: 171.0 166.0 166.0 165.0 177.0 170.0 171.0 168.0 168.0 174.0 09:21:47 INFO - PROCESS | 31833 | 09:21:47 INFO - PROCESS | 31833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.58 (2.3%) stddev-sans-first:1.67 09:21:47 INFO - PROCESS | 31833 | Values: 69.0 68.0 68.0 69.0 68.0 71.0 68.0 67.0 71.0 66.0 09:21:47 INFO - PROCESS | 31833 | -------- Summary: end -------- 09:21:47 INFO - PROCESS | 31833 | 09:21:48 INFO - TEST-INFO | 31833: exit 0 09:21:49 INFO - TEST-OK | kraken | took 63583ms 09:21:49 INFO - SUITE-END | took 1183s 09:21:49 INFO - Completed test suite (00:19:43) 09:21:49 INFO - javascript benchmark 09:21:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.1432727200026, 2606.8696565171745, 2616.3589920469476, 2618.3977685132418, 2641.7754490868274, 4617.468991066028, 4700.6944548604315, 4750.643701722372, 4761.023990082033, 4794.544518270759, 4619.0, 4711.104890070884, 4721.150192965273, 4732.266498692699, 4795.544423279792, 4296.0978194579175, 4300.6989510734265, 4373.978130109345, 4422.889427764299, 4497.370368148446, 4440.156370289651, 4460.063386688799, 4481.215787237236, 4493.68544201906, 4510.300903359985, 4277.743335399886, 4308.030693094061, 4341.565843415665, 4345.50026746925, 4352.847650332224, 4323.805428755713, 4375.562443755599, 4439.467263928317, 4456.910861782779, 4470.731756094645, 4316.330968699856, 4370.12597480502, 4395.802188901507, 4427.0, 4436.3123715824095, 4754.477007529169, 4812.0375924814825, 4842.201036828919, 4849.418069831608, 4857.6599638025355, 4960.50394960501, 4961.925571116436, 5031.4465408805, 5034.194528875362, 5092.9236061459105, 5072.923906141374, 5083.440821509631, 5123.1546794778815, 5137.5633071188995, 5141.15170996785, 4586.036932244199, 4750.14497390473, 4759.333693282943, 4759.785809638574, 4768.117898188846, 5212.4266330703595, 5277.736113194325, 5286.97356513215, 5332.120200166929, 5352.143657014937, 5066.138756411346, 5072.239164125411, 5121.052605268037, 5126.743662816844, 5126.846194614168, 4992.525710057539, 5202.063628546898, 5218.843434696889, 5220.034293655686, 5226.503482169188, 4956.430010548761, 4997.175466048134, 5019.67372120811, 5043.067032598981, 5093.719845408464, 5001.0, 5003.924941125886, 5003.949960500421, 5021.472745361758, 5065.265536497187, 4200.348945913388, 4303.117860838521, 4309.892252693708, 4313.3098704207805, 4364.10535840152, 3699.075231192202, 3705.629437056327, 3734.3838266686234, 3777.58446570877, 3791.298609757204, 4357.193919124972, 4364.672649551297, 4365.672574556857, 4378.978105109454, 4409.338599210144, 5072.6195535335, 5074.568661663726, 5076.289319495274, 5080.415752188472, 5115.028144652579, 4267.509236437787, 4275.978620106879, 4294.6564274858565, 4328.285832837547, 4405.493368262691, 4557.156925968707, 4565.406497155349, 4585.426821647294, 4594.632429405639, 4617.746023968714, 4753.120672675566, 4758.024604955906, 4782.234842425195, 4785.210440277455, 4809.038192361541, 4971.154903666457, 5020.723860187579, 5082.644214904921, 5089.389273287081, 5099.87250318745, 4694.7417892016265, 4709.0, 4747.881302967316, 4765.451973023147, 4807.6394270429155, 4984.352034235526, 4987.925181122214, 4989.226669866177, 4989.792480130033, 5038.874028149326, 4874.976254986493, 5050.924236136388, 5053.494650534917, 5054.4187418447345, 5105.18317069282, 4846.80612775485, 4867.975660121677, 4872.805087796449, 4935.876603084952, 4992.0, 4894.2658601210105, 4913.877153071202, 4924.064427758714, 4928.926066108939, 4971.254311853251, 4737.573618374363, 4838.637102217277, 4854.150523658275, 4902.828401005948, 4907.68100073494, 4931.802727890844, 4970.701757894538, 4972.453030166606, 4985.775640096277, 5052.292679024866, 4863.878403039952, 4876.21980483121, 4882.902341953212, 4892.339534162842, 4929.383827021622], "value": 4660.526467333312, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8211854325159, 582.8950788858003, 584.9473547380735, 585.3882692586247, 592.6414519215875, 27537.0, 30269.09192724219, 30428.93498727548, 42593.78703106488, 44334.0, 41179.17641647165, 41672.166556668846, 41761.0, 41768.79115604418, 41794.37308440376, 7697.2302769722855, 7820.843583128334, 7827.491213071161, 7836.451448398586, 7845.137034926153, 7383.48315617907, 7876.80307992299, 7968.083670377923, 9850.507474626276, 10156.746081347988, 10236.0, 10306.587736490532, 10307.484625768719, 10308.536115874766, 10318.638847640334, 10074.597016119347, 10100.343477673965, 10101.444420556867, 10119.797604047877, 10130.138938190263, 9973.850392244121, 10054.69835904924, 10063.69808905734, 10064.144547713453, 10067.04363085513, 38890.22219555593, 39110.60889391127, 39219.0, 39227.0, 39309.80345098256, 2795.3291210109633, 2831.065748303055, 3032.438998785232, 3078.8768449262, 3261.1194977356217, 29120.505539335205, 29296.0, 29470.557941630894, 29506.262343441373, 30185.69814301873, 3269.362474317509, 3351.581052368454, 3382.830858457092, 3413.197898493852, 3452.723782097426, 270870.0, 276536.0, 276563.0, 277631.0, 278113.0, 56091.0, 56426.71786641041, 56539.15191272134, 56560.717196414575, 56795.0, 32943.176420589676, 34037.0, 58639.70680146572, 58670.11994820081, 58687.41312586905, 14278.07192532482, 14617.634559136106, 14624.707505849823, 14632.268386580628, 14635.634109147357, 11006.779864402668, 11205.0, 11209.775804483865, 11210.215284929976, 11212.663620091247, 16127.758083628754, 17890.5527361817, 18731.250749969848, 18757.155927983273, 19373.709394359095, 6863.897041544381, 6905.965470172617, 7007.299270072952, 7025.859482810315, 7065.92934070663, 847.3687103108224, 861.2507118806678, 907.6188001039579, 929.9953500232456, 940.5250348573926, 28597.0, 29195.41609167847, 29326.26684332909, 29744.851275743484, 29800.40399192004, 962.6582563190107, 989.737719504332, 1006.3509036671306, 1027.7995790820867, 1050.989490105089, 14306.928465357814, 15273.159976201194, 15437.459688910834, 15467.690646187013, 15577.515145496167, 406165.0, 410335.0, 411698.0, 412109.0, 412639.0, 49598.75200624046, 49717.75141124271, 50046.499535004186, 50070.499295007314, 50169.49830501648, 1069.2034434346463, 1112.732944093428, 1119.1158984402232, 1185.549491193341, 1187.074082215873, 25509.744902550738, 27269.0, 29279.121626351243, 29436.26409339698, 30018.0, 44357.556424435345, 45149.54850451453, 45168.77415612901, 45178.322325165806, 45268.0, 370031.0, 374347.0, 374882.0, 375488.0, 375875.0, 38533.0, 39716.602833971294, 40147.0, 40645.39031914583, 43153.56846431621, 41199.1760164801, 41514.79242603888, 41886.79056604819, 41900.58099419089, 43202.13595728131, 36088.4586731194, 36356.0, 36357.0, 36503.0, 36952.26095478021, 36673.266534668626, 36755.44866827053, 37053.0, 37268.44097338488, 37750.811245943594, 36463.453048203766, 36673.81663091774, 37041.25917481689, 37143.44284835675, 37556.81221593874, 31651.841740791147, 33457.49813752747, 33532.0, 33883.15292117717, 34091.14772130716, 25667.0, 25760.871195644653, 25796.871015645553, 25845.870770646026, 26003.869980649975], "value": 18426.98070127072, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.09153830426993, 337.96789305016017, 357.87653259625426, 358.1154548265783, 362.84216365880843, 12822.0, 16167.272472738725, 16396.508104756846, 17321.39375121871, 18405.815941840578, 16517.256723447445, 16535.0, 16549.25528351224, 16702.7494587581, 16748.83251167488, 4922.114019476493, 4962.851114466554, 5067.315912351823, 5096.0, 5102.387713474388, 3677.5586929568353, 5053.090443720129, 5122.129238029544, 5133.563647090002, 5614.66312021278, 5888.32284287306, 5962.493188078996, 5973.104034394853, 5982.940170598282, 5994.580379373424, 5730.4269573042775, 5917.408259174092, 5961.076033214858, 5968.850778730523, 6014.218151640259, 5219.19102539107, 5220.086484865134, 5222.817201397933, 5225.608079394061, 5228.163493840967, 20817.5836483271, 21153.576928461345, 21320.0, 21339.893300533553, 21803.781962180336, 1841.3831366492107, 2004.5690176611952, 2244.5062086340977, 2393.628987506939, 2408.843425177358, 12958.0, 13163.670908227276, 13226.0, 14024.0, 14031.298435078204, 1700.6683696679152, 1717.398910381369, 1765.4438851761781, 1767.9823201768074, 1805.2057094878212, 63078.68460657667, 67027.32972670259, 67231.0, 67714.0, 68152.97770533495, 8892.688755893512, 8936.0, 9117.130988147414, 9269.351145419756, 9465.290103242285, 11946.701332466584, 11955.581554645545, 11970.521179152911, 11977.0, 11983.16117871758, 6833.555818871758, 6966.338197871194, 6970.825729356807, 7107.289271072955, 7123.643817809088, 6735.865282694319, 6751.527393082437, 6906.102206713195, 6926.826829329207, 6928.861422771516, 6037.758489660365, 6043.033114701627, 6237.96881015592, 6254.405831446005, 6264.467520260738, 1644.4162322375623, 1647.217571653479, 1700.617361093744, 1744.3807448355906, 1759.4545690835882, 829.5064436660177, 846.3525403066659, 862.9352798540135, 909.231699214163, 926.9351145419756, 16894.49316520506, 17900.641987160183, 18254.36109736153, 18557.35049273296, 18647.44057678272, 850.425962475339, 868.9608967596473, 873.8907636545432, 897.7620930453435, 935.1209862729013, 9687.467189304656, 10583.841242381217, 10608.734781630521, 10653.467326633638, 10709.0, 376040.0, 380702.0, 381839.0, 388063.0, 389565.0, 67343.66328168426, 69703.30296697069, 70021.2997870025, 71630.0, 72082.0, 867.3018220332567, 913.712180663089, 920.1120918313859, 924.2421214604094, 926.666400095965, 15796.187230310803, 15957.521274361789, 16575.668486630442, 16784.916075419544, 16860.0, 38914.2217155661, 39460.60539394569, 40033.599664002984, 40046.799766000986, 41295.1740965185, 52309.47690523046, 52734.208986866, 53225.46774532205, 54723.905521890134, 54844.17733733918, 7406.518576292524, 7639.197884222299, 7694.653740581799, 7780.066392032766, 7809.297163255334, 8453.95773021131, 11516.0, 11904.76190476203, 12166.844149805755, 12178.695532611755, 10331.0, 10379.792404152025, 10440.791184176425, 10962.835557466804, 10969.451527423438, 10293.330933489598, 10393.896061039293, 10562.207834412604, 10563.788724225626, 10913.0, 9896.20830333586, 10332.276740628084, 10752.13982881352, 10798.892011080103, 11219.66341009771, 7386.778396648109, 7552.886706699294, 7625.504342217738, 7642.273983971514, 7772.68909243624, 9787.657431989846, 10156.136728378171, 10315.17478601725, 10587.89412105869, 10905.291156074829], "value": 8383.959123162014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.3540641163393, 1336.7727486327321, 1368.452618952419, 1421.7654087075632, 1682.9663406731866, 6605.339466053392, 7323.890141647879, 7590.620468976543, 7613.162552119269, 7836.8040798980055, 7660.042494688164, 7693.961530192341, 7698.114716807569, 7699.268569485904, 7704.422168337369, 2151.7095192149054, 2170.4790850195996, 2173.717416735822, 2176.793204645556, 2177.4556360909774, 2108.11459187141, 2144.957100857982, 2150.731158605174, 2154.709114269577, 2155.892205389724, 2094.52873103552, 2111.5354621983215, 2130.6164890319737, 2136.295022642524, 2147.6241657709916, 2099.77952315007, 2104.6842973553935, 2106.441792924876, 2108.1040557762967, 2108.388567315477, 2033.1257559249516, 2116.544942837282, 2117.333040092366, 2117.3965419855267, 2121.278765219817, 7573.394128469709, 7654.043244594426, 7682.193369696213, 7734.110577283628, 7734.419918506078, 4296.484421869396, 4427.535108813592, 4435.756033418161, 4494.011317510142, 4495.910081798378, 2754.6832114306912, 2867.7562407195414, 2880.135959212249, 2882.409106133238, 2902.1148549692334, 908.8682141089571, 914.8033172867865, 920.9631614735403, 925.5464822237122, 932.4638332958576, 10311.0, 10368.948155259252, 10409.479526023744, 10418.947905260426, 10425.687229383131, 3694.8891533254045, 3944.6449819516383, 4018.738781979162, 4040.676745860324, 4054.2499637567144, 7991.8811366408745, 7996.9200307997335, 7996.960015199887, 8000.239977202156, 8012.0, 4428.424304840414, 4444.444444444444, 4449.154660614473, 4450.755208463501, 4454.576815202616, 3553.804540750232, 3634.6910512606196, 3897.2205558888336, 4118.9588104118575, 4120.320147175742, 3208.2941752814345, 3236.5954255718034, 3340.8997730068136, 3359.311341175102, 3361.075704181321, 942.4062840410497, 983.9852402213972, 984.07988530724, 997.9201663866874, 1003.4731765823001, 736.7126820539994, 782.0732432068017, 782.9177936316719, 789.9170587088273, 802.967881284742, 5154.5103215194495, 5197.792088316501, 5249.973750131225, 5277.883251064176, 5433.320834895638, 389.5072732992766, 393.30188914676677, 406.69497876592555, 410.4622943943444, 414.4756882543585, 3551.360755064113, 3682.2819550187455, 3688.870889518854, 3698.001539584297, 3726.087108658396, 9232.676856309998, 9700.078492543196, 9718.465484398426, 9739.220862330996, 9742.07450292221, 8922.420042697204, 9177.587008584629, 9586.616535338508, 9595.13643772064, 9605.37565058269, 7132.893006604905, 7356.632168391559, 7364.594947277951, 7376.225496322809, 7377.077865266841, 5348.7593058311695, 5422.810201642924, 5456.454354564512, 5532.004239236976, 5581.906784955641, 8437.746867593982, 8590.055093939787, 8632.91367086321, 8697.304215662858, 8866.911330886609, 8853.778655533662, 8854.822903541764, 8966.506842123747, 9021.503817290111, 9075.364724469224, 5810.215620891295, 6584.176977877765, 6727.764528241488, 6730.125083739083, 6731.596104233566, 6651.567648102858, 6815.114035175396, 6886.414654754402, 6893.620850853251, 7193.244709305657, 6616.735330586916, 6650.600963942179, 6756.493263005393, 6841.521093523605, 6925.896111558432, 6595.208574971034, 6598.340165983555, 6600.669966501559, 6602.735890564516, 6698.56459330142, 6004.39956004396, 6101.450869421773, 6106.480949119375, 6107.206063211754, 6107.572469927062, 4501.2347900857585, 4650.767461626972, 4656.906861862812, 4713.9292910607055, 4775.976120119377, 4588.334691469785, 4595.862124136282, 4637.744924029076, 4709.105269998689, 4950.727709975986], "value": 3934.512786376953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.493708855516, 285.43723115940224, 294.7067667670668, 295.2338681122486, 301.78422427964, 4556.225441674915, 4731.0, 4750.859793649525, 4761.90476190476, 4773.140834649766, 4515.412996310483, 4679.27471241958, 4704.776758042908, 4714.104320179172, 4739.289106634006, 3736.7481893565687, 3746.4193050077283, 3751.493548370969, 3756.7370284080125, 3761.2289480656536, 3574.1422058705853, 3757.66181043706, 3760.2291530236234, 3763.56718977317, 3765.811709414532, 3514.9648503514895, 3703.7962912039825, 3718.9628103718887, 3729.7948612826285, 3740.625937406251, 3709.202521457886, 3717.345781127386, 3733.6453036961443, 3735.8879233623034, 3747.2130852521004, 3278.1149089745873, 3281.6390197078304, 3284.7372210223366, 3287.917802054944, 3295.8794010036463, 4495.370648109268, 4596.0, 4634.976825115887, 4640.839790052487, 4666.136764698507, 4238.512571054337, 4244.787760611957, 4246.108317253381, 4251.59609837065, 4282.443282373302, 4956.7199088419375, 4973.477784832577, 4976.934572152552, 4978.626603004789, 4979.800807967713, 3351.916202094967, 3496.143444856001, 3507.789532628025, 3508.8771892983877, 3612.1330880588735, 5137.691738495702, 5163.509466600667, 5168.534831865112, 5181.171012637959, 5200.323957885488, 3593.82030898454, 3597.5503062117236, 3610.0, 3617.385044542434, 3623.221007483404, 3453.9481907771406, 3652.1782598915033, 3675.320065787784, 3689.741718079709, 3696.094456858087, 4148.605882441163, 4150.315197992298, 4164.333706606928, 4173.728707633994, 4173.791310434466, 4946.505349465025, 4947.65366424354, 4948.901021979612, 4959.776810043557, 4972.825951091694, 1199.9100067494974, 1220.170284206748, 1235.116891422637, 1246.9127161098636, 1252.4614415801293, 845.1421806866036, 862.4911302331654, 865.6061492021115, 869.5391442535466, 872.7469033980202, 4373.803178856959, 4377.430933978562, 4381.715188512737, 4384.298512238091, 4403.361512580658, 5068.290439338495, 5105.897882042413, 5106.795728170831, 5113.386393632788, 5121.489160697603, 4246.747209573184, 4360.345948107809, 4459.996500787362, 4475.395821564047, 4480.372747815309, 2697.5953606959115, 2723.6595425571804, 2724.741149590786, 2725.1552018874213, 2748.670159580863, 4804.045512010089, 4848.17581011229, 4850.805967761321, 4854.271859221145, 4857.611391088704, 5083.644144909895, 5228.784297656914, 5250.579953603703, 5251.76367063483, 5253.632245742761, 4812.133815913099, 4848.418189817104, 4893.804247830119, 4896.804127834918, 4905.3623029006, 5038.603005394839, 5117.181250999822, 5121.436641969306, 5141.305923700253, 5170.6380553360905, 5001.824936127364, 5007.624428167829, 5027.673201241908, 5028.522290382408, 5039.496050395078, 4853.126437241331, 4855.854324370133, 4869.926951095807, 4873.756312184448, 4901.362822833009, 3593.568771747407, 3599.478075679064, 3615.132368231658, 3615.427289129237, 3620.7103431725927, 5004.47453017428, 5031.496850315086, 5112.696262453051, 5156.1492353761205, 5160.767765450639, 4999.0, 5005.099082165245, 5013.523715247045, 5020.272060551127, 5020.824271150492, 4928.260760885896, 4953.9752301239705, 4963.205887058053, 4989.326440930573, 5056.469070747518, 4651.2557990721325, 4652.185867473247, 4743.217369134054, 4901.142300097397, 4914.8771280718265, 4995.300657907823, 5003.0, 5010.423801262901, 5011.949880501148, 5024.42219144803, 4894.779734912009, 4911.287863259879, 4926.48271931442, 4935.506449355035, 4943.209086546135], "value": 3748.919522014775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9063506752511, 631.8925782616955, 632.6393955445398, 723.7286017743346, 724.9452047271221, 11399.202055856093, 12072.396380180979, 12106.576269830557, 12125.454354554044, 12130.939345303283, 13013.80479292809, 13220.867791322084, 13255.93372033141, 13264.933675331635, 13269.601911942656, 615.7752420366579, 747.0325927923338, 756.0662581711582, 768.5427170833373, 772.1236396689769, 764.9961750191242, 776.9689212431496, 777.4169372970272, 778.0857492446381, 778.1168373895613, 819.7622689420061, 825.8100636853527, 826.4256341842422, 826.7850358906697, 827.5903427803246, 651.1144843013498, 786.4337676872642, 807.4953154278576, 822.8518866604009, 823.1521532821174, 591.6361437715774, 595.0508938243495, 595.1845971019687, 595.3421469276431, 595.5295316699802, 12309.507619695201, 12347.135700500969, 12350.0737444692, 12360.814587781191, 12378.195417297937, 11508.424578771112, 11721.648350549498, 11771.470283837161, 11797.528098876035, 12777.680557986032, 9732.854007189897, 10007.549660265306, 11887.762244755142, 11890.583829565923, 11890.643280701594, 4118.794060296973, 4125.64931980782, 4180.331147016463, 4217.936730949038, 4328.307470804688, 65693.99999999952, 65893.3410665892, 67029.0, 67188.3281167187, 67198.3280167197, 9207.907920920705, 9215.90784092164, 9381.90618093824, 9540.522973851279, 9619.51902404877, 17046.318147274218, 17306.913465432594, 17444.825551744572, 17456.127193640266, 18092.366767163086, 6440.774572889926, 6492.740290388426, 6520.282768895418, 6535.444487218545, 6668.433183179484, 3632.4914511968345, 3636.781793092423, 3657.8719744808805, 3676.9632303677154, 3682.226732386229, 2703.297142742901, 2805.5230610796216, 2832.5326321156776, 2836.1208025512155, 2850.2589326775187, 509.1802198460476, 512.101262284688, 514.8095204774182, 515.7498613172609, 520.4795204795205, 551.8537587539305, 592.4312659846596, 600.1747597054051, 603.3003496175002, 611.5291225756143, 7910.0, 8035.879461808077, 8080.9191908080165, 8175.182481751896, 8373.748787536384, 461.88914660481913, 507.66747780204025, 519.5194445138231, 566.4816692726192, 576.8932747441737, 3751.868684596026, 3820.6179382061573, 3904.375299951994, 3970.781607011642, 4089.1821635672986, 80601.59699201466, 81423.59288203639, 97444.51277743567, 100937.0, 101432.49283753682, 91405.54297228472, 93603.0, 93659.53170234241, 93781.53109234547, 94359.52820235855, 77609.61195194101, 78987.0, 80076.0, 80973.0, 81287.0, 8159.184081591793, 8766.167214114648, 8834.823303534022, 8909.420887642542, 9034.27725781949, 45470.31794523151, 46306.0, 46557.53442465532, 47159.0, 48003.5199647999, 37309.81345093366, 38932.221355573296, 42911.57088429201, 43019.78490107655, 44517.0, 10411.687649370531, 10781.029707326064, 10832.458377081271, 10858.67423977282, 11392.0, 13239.801402979156, 13487.393067311797, 13547.729045418839, 13640.590782276548, 14074.749679779557, 11462.598809041643, 11745.47145378443, 11799.410029498662, 12194.146409751233, 12209.38953052326, 10818.729531761453, 11263.7747245053, 12605.495780169058, 12607.0, 12625.0, 12013.629532637844, 12214.633560993185, 12549.120915698237, 12681.8097728536, 12938.223706577635, 10027.799444010932, 10222.642207522998, 10307.433091180057, 10394.844077338998, 10633.415162166155, 8884.045509987793, 9416.293777966543, 10118.139958103644, 10367.377957322586, 10452.425116618659], "value": 6496.055636926617, "unit": "score"}], "name": "dromaeo_css", "value": 6404.324242619484, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 113.0, 113.0, 114.0, 115.0, 114.0, 115.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 124.0, 192.0, 127.0, 129.0, 147.0, 127.0, 165.0, 121.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 128.0, 78.0, 76.0, 75.0, 76.0, 102.0, 75.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 121.0, 86.0, 86.0, 86.0, 131.0, 86.0, 86.0, 121.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 145.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 60.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 79.0, 80.0, 80.0, 80.0, 79.0, 80.0, 84.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 131.0, 130.0, 130.0, 130.0, 130.0, 127.0, 136.0, 175.0, 129.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 166.0, 165.0, 177.0, 170.0, 171.0, 168.0, 168.0, 174.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 68.0, 71.0, 68.0, 67.0, 71.0, 66.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1538.1999999999998, "alertThreshold": 2.0}]} 09:21:49 INFO - Return code: 0 09:21:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:21:49 INFO - # TBPL SUCCESS # 09:21:49 INFO - Running post-action listener: _resource_record_post_action 09:21:49 INFO - [mozharness: 2016-07-28 16:21:49.253900Z] Finished run-tests step (success) 09:21:49 INFO - Running post-run listener: _resource_record_post_run 09:21:49 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536469504; Read time: 40; Write time: 567592 09:21:49 INFO - TinderboxPrint: CPU usage
13.0% 09:21:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 40 09:21:49 INFO - TinderboxPrint: I/O write bytes / time
536,469,504 / 567,592 09:21:49 INFO - TinderboxPrint: CPU idle
8,333.2 (87.0%) 09:21:49 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 09:21:49 INFO - TinderboxPrint: Swap in / out
0 / 0 09:21:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247017472; Read time: 0; Write time: 334752 09:21:49 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289452032; Read time: 40; Write time: 232840 09:21:49 INFO - Running post-run listener: _upload_blobber_files 09:21:49 INFO - Blob upload gear active. 09:21:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:49 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 09:21:49 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:21:49 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:21:50 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:21:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:52 INFO - (blobuploader) - INFO - Done attempting. 09:21:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:21:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:21:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:52 INFO - (blobuploader) - INFO - Done attempting. 09:21:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:21:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:21:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:58 INFO - (blobuploader) - INFO - Done attempting. 09:21:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:58 INFO - Return code: 0 09:21:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/728c4ebf819a57d9aedf005e6b460ce7c90db7baf891a4da422c5aeb602c870cb646cef4c45779f5e8cb5f0359175c4b9af6744365992d4cfaa401cfc8643e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19de29218ba182fa32d8cc3cbe922212283a61ded0a168d69b3ba1096b81cd9a8d06febae13ca192a48a71d8aa89258414d10107051ba0e2e14b94dad63eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53e3fad5019f84420460ba40b4c61a1e844057e7442ccc48558aef5d9671bed3c7b76248a4a76f4094d557fd3cc8c6a359149b5f425229cd26816f6a3e54f9a2"} 09:21:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:58 INFO - Contents: 09:21:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/728c4ebf819a57d9aedf005e6b460ce7c90db7baf891a4da422c5aeb602c870cb646cef4c45779f5e8cb5f0359175c4b9af6744365992d4cfaa401cfc8643e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19de29218ba182fa32d8cc3cbe922212283a61ded0a168d69b3ba1096b81cd9a8d06febae13ca192a48a71d8aa89258414d10107051ba0e2e14b94dad63eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53e3fad5019f84420460ba40b4c61a1e844057e7442ccc48558aef5d9671bed3c7b76248a4a76f4094d557fd3cc8c6a359149b5f425229cd26816f6a3e54f9a2"} 09:21:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:58 INFO - Copying logs to upload dir... 09:21:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.594306 ========= master_lag: 1.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-28 09:21:59.819317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 09:21:59.822662) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/728c4ebf819a57d9aedf005e6b460ce7c90db7baf891a4da422c5aeb602c870cb646cef4c45779f5e8cb5f0359175c4b9af6744365992d4cfaa401cfc8643e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19de29218ba182fa32d8cc3cbe922212283a61ded0a168d69b3ba1096b81cd9a8d06febae13ca192a48a71d8aa89258414d10107051ba0e2e14b94dad63eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53e3fad5019f84420460ba40b4c61a1e844057e7442ccc48558aef5d9671bed3c7b76248a4a76f4094d557fd3cc8c6a359149b5f425229cd26816f6a3e54f9a2"} build_url:https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/WfyPK3rwTvWMdMPJbLIVfw/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/Fx-Team-Non-PGO/sha512/728c4ebf819a57d9aedf005e6b460ce7c90db7baf891a4da422c5aeb602c870cb646cef4c45779f5e8cb5f0359175c4b9af6744365992d4cfaa401cfc8643e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e19de29218ba182fa32d8cc3cbe922212283a61ded0a168d69b3ba1096b81cd9a8d06febae13ca192a48a71d8aa89258414d10107051ba0e2e14b94dad63eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53e3fad5019f84420460ba40b4c61a1e844057e7442ccc48558aef5d9671bed3c7b76248a4a76f4094d557fd3cc8c6a359149b5f425229cd26816f6a3e54f9a2"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 09:21:59.995918) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:21:59.996249) ========= 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=14ef55db36f7623abb31b9cf000001d5-1469720539.46457-482000582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:22:00.088621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 09:22:00.088975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 09:22:00.089310) ========= ========= Total master_lag: 1.68 =========