builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1470084467.2 results: success (0) buildid: 20160801125249 builduid: 6440304f9ed245f48878e0bd76db7589 revision: e8b7e5dc300463a6bc5ecd5813329d6acce02982 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.200812) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.201363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.201678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.218095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.218411) ========= 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=826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 13:47:49-- 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% 40.7M=0s 2016-08-01 13:47:49 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.315269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.315622) ========= 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=826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:47.364762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 13:47:47.365188) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e8b7e5dc300463a6bc5ecd5813329d6acce02982 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e8b7e5dc300463a6bc5ecd5813329d6acce02982 --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=826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 13:47:50,000 truncating revision to first 12 chars 2016-08-01 13:47:50,000 Setting DEBUG logging. 2016-08-01 13:47:50,000 attempt 1/10 2016-08-01 13:47:50,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e8b7e5dc3004?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 13:47:51,122 unpacking tar archive at: autoland-e8b7e5dc3004/testing/mozharness/ program finished with exit code 0 elapsedTime=1.441608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 13:47:48.820901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:48.821236) ========= script_repo_revision: e8b7e5dc300463a6bc5ecd5813329d6acce02982 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:48.821614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:48.821877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 13:47:48.832681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-01 13:47:48.833036) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:47:51 INFO - MultiFileLogger online at 20160801 13:47:51 in /builds/slave/test 13:47:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 13:47:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:47:51 INFO - {'append_to_log': False, 13:47:51 INFO - 'base_work_dir': '/builds/slave/test', 13:47:51 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:47:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:47:51 INFO - 'branch': 'Autoland-Non-PGO', 13:47:51 INFO - 'buildbot_json_path': 'buildprops.json', 13:47:51 INFO - 'config_files': ('talos/linux_config.py',), 13:47:51 INFO - 'default_actions': ('clobber', 13:47:51 INFO - 'read-buildbot-config', 13:47:51 INFO - 'download-and-extract', 13:47:51 INFO - 'populate-webroot', 13:47:51 INFO - 'create-virtualenv', 13:47:51 INFO - 'install', 13:47:51 INFO - 'run-tests'), 13:47:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:47:51 INFO - 'download_minidump_stackwalk': True, 13:47:51 INFO - 'download_symbols': 'ondemand', 13:47:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:47:51 INFO - 'tooltool.py': '/tools/tooltool.py', 13:47:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:47:51 INFO - '/tools/misc-python/virtualenv.py')}, 13:47:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:47:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:47:51 INFO - 'installer_path': 'installer.exe', 13:47:51 INFO - 'log_level': 'info', 13:47:51 INFO - 'log_name': 'talos', 13:47:51 INFO - 'log_to_console': True, 13:47:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:47:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:47:51 INFO - 'opt_config_files': (), 13:47:51 INFO - 'pip_index': False, 13:47:51 INFO - 'sps_profile': False, 13:47:51 INFO - 'sps_profile_interval': 0, 13:47:51 INFO - 'suite': 'dromaeojs', 13:47:51 INFO - 'system_bits': '32', 13:47:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:47:51 INFO - 'title': 'talos-linux64-ix-052', 13:47:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:47:51 INFO - 'use_talos_json': True, 13:47:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:47:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:47:51 INFO - 'work_dir': 'build'} 13:47:51 INFO - [mozharness: 2016-08-01 20:47:51.557028Z] Running clobber step. 13:47:51 INFO - Running pre-action listener: _resource_record_pre_action 13:47:51 INFO - Running main action method: clobber 13:47:51 INFO - rmtree: /builds/slave/test/build 13:47:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:47:52 INFO - Running post-action listener: _resource_record_post_action 13:47:52 INFO - [mozharness: 2016-08-01 20:47:52.023642Z] Finished clobber step (success) 13:47:52 INFO - [mozharness: 2016-08-01 20:47:52.023743Z] Running read-buildbot-config step. 13:47:52 INFO - Running pre-action listener: _resource_record_pre_action 13:47:52 INFO - Running main action method: read_buildbot_config 13:47:52 INFO - Using buildbot properties: 13:47:52 INFO - { 13:47:52 INFO - "project": "", 13:47:52 INFO - "product": "firefox", 13:47:52 INFO - "script_repo_revision": "production", 13:47:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:47:52 INFO - "repository": "", 13:47:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:47:52 INFO - "buildid": "20160801125249", 13:47:52 INFO - "pgo_build": "False", 13:47:52 INFO - "basedir": "/builds/slave/test", 13:47:52 INFO - "buildnumber": 279, 13:47:52 INFO - "slavename": "talos-linux64-ix-052", 13:47:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:47:52 INFO - "platform": "ubuntu64_hw", 13:47:52 INFO - "scheduler": "tests-autoland-linux64-talos", 13:47:52 INFO - "branch": "autoland", 13:47:52 INFO - "repo_path": "integration/autoland", 13:47:52 INFO - "revision": "e8b7e5dc300463a6bc5ecd5813329d6acce02982", 13:47:52 INFO - "stage_platform": "linux64", 13:47:52 INFO - "builduid": "6440304f9ed245f48878e0bd76db7589", 13:47:52 INFO - "slavebuilddir": "test" 13:47:52 INFO - } 13:47:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:47:52 INFO - Running post-action listener: _resource_record_post_action 13:47:52 INFO - [mozharness: 2016-08-01 20:47:52.026173Z] Finished read-buildbot-config step (success) 13:47:52 INFO - [mozharness: 2016-08-01 20:47:52.026262Z] Running download-and-extract step. 13:47:52 INFO - Running pre-action listener: _resource_record_pre_action 13:47:52 INFO - Running main action method: download_and_extract 13:47:52 INFO - mkdir: /builds/slave/test/build/tests 13:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:52 INFO - https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:47:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:47:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:47:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:53 INFO - Downloaded 1361 bytes. 13:47:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:47:53 INFO - Using the following test package requirements: 13:47:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:47:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:47:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'jsshell-linux-x86_64.zip'], 13:47:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:47:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:47:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:47:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:47:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:47:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:53 INFO - https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:54 INFO - Downloaded 20237990 bytes. 13:47:54 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'] 13:47:54 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 13:47:55 INFO - Return code: 0 13:47:55 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 13:47:55 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')]} 13:47:55 INFO - https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:56 INFO - Downloaded 20237990 bytes. 13:47:56 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'] 13:47:56 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 13:47:57 INFO - Return code: 0 13:47:57 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')]} 13:47:57 INFO - https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:58 INFO - Downloaded 14413723 bytes. 13:47:58 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'] 13:47:58 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 13:47:58 INFO - Return code: 0 13:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:58 INFO - https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:47:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:47:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:47:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:47:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UsrjDL3-R9CZfj1Uehy5pg/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 13:48:00 INFO - Downloaded 55672103 bytes. 13:48:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:00 INFO - mkdir: /builds/slave/test/properties 13:48:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:00 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:00 INFO - Contents: 13:48:00 INFO - build_url:https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:00 INFO - Running post-action listener: _resource_record_post_action 13:48:00 INFO - Running post-action listener: set_extra_try_arguments 13:48:00 INFO - [mozharness: 2016-08-01 20:48:00.816969Z] Finished download-and-extract step (success) 13:48:00 INFO - [mozharness: 2016-08-01 20:48:00.817201Z] Running populate-webroot step. 13:48:00 INFO - Running pre-action listener: _resource_record_pre_action 13:48:00 INFO - Running main action method: populate_webroot 13:48:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:48:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:48:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:48:00 INFO - '--tppagecycles', 13:48:00 INFO - '7'], 13:48:00 INFO - 'tests': ['tsvgm']}}, 13:48:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:48:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:48:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:48:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:48:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['damp', 'tps']}, 13:48:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'tests': ['damp', 'tps']}, 13:48:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['dromaeo_dom']}, 13:48:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:48:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['basic_compositor_video']}, 13:48:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:48:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['a11yr', 13:48:00 INFO - 'ts_paint', 13:48:00 INFO - 'tpaint', 13:48:00 INFO - 'sessionrestore', 13:48:00 INFO - 'sessionrestore_no_auto_restore', 13:48:00 INFO - 'tabpaint']}, 13:48:00 INFO - 'other-e10s': {'tests': ['a11yr', 13:48:00 INFO - 'ts_paint', 13:48:00 INFO - 'tpaint', 13:48:00 INFO - 'sessionrestore', 13:48:00 INFO - 'sessionrestore_no_auto_restore', 13:48:00 INFO - 'tabpaint']}, 13:48:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:48:00 INFO - 'ts_paint', 13:48:00 INFO - 'tpaint', 13:48:00 INFO - 'sessionrestore', 13:48:00 INFO - 'sessionrestore_no_auto_restore', 13:48:00 INFO - 'tabpaint']}, 13:48:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:48:00 INFO - 'ts_paint', 13:48:00 INFO - 'tpaint', 13:48:00 INFO - 'sessionrestore', 13:48:00 INFO - 'sessionrestore_no_auto_restore', 13:48:00 INFO - 'tabpaint']}, 13:48:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['a11yr', 13:48:00 INFO - 'ts_paint', 13:48:00 INFO - 'tpaint', 13:48:00 INFO - 'sessionrestore', 13:48:00 INFO - 'sessionrestore_no_auto_restore', 13:48:00 INFO - 'tabpaint']}, 13:48:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['a11yr', 13:48:00 INFO - 'ts_paint', 13:48:00 INFO - 'tpaint', 13:48:00 INFO - 'sessionrestore', 13:48:00 INFO - 'sessionrestore_no_auto_restore', 13:48:00 INFO - 'tabpaint']}, 13:48:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['tsvgx', 13:48:00 INFO - 'tsvgr_opacity', 13:48:00 INFO - 'tart', 13:48:00 INFO - 'tscrollx', 13:48:00 INFO - 'cart']}, 13:48:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:48:00 INFO - 'tsvgr_opacity', 13:48:00 INFO - 'tart', 13:48:00 INFO - 'tscrollx', 13:48:00 INFO - 'cart']}, 13:48:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'talos_options': ['--disable-e10s'], 13:48:00 INFO - 'tests': ['tp5o']}, 13:48:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'tests': ['tp5o']}, 13:48:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'talos_options': ['--disable-e10s', 13:48:00 INFO - '--xperf_path', 13:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:00 INFO - 'tests': ['tp5n']}, 13:48:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:00 INFO - 'talos_options': ['--xperf_path', 13:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:00 INFO - 'tests': ['tp5n']}}, 13:48:00 INFO - 'talos.zip': {'path': '', 13:48:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:48:00 INFO - Running post-action listener: _resource_record_post_action 13:48:00 INFO - [mozharness: 2016-08-01 20:48:00.835697Z] Finished populate-webroot step (success) 13:48:00 INFO - [mozharness: 2016-08-01 20:48:00.835785Z] Running create-virtualenv step. 13:48:00 INFO - Running pre-action listener: _resource_record_pre_action 13:48:00 INFO - Running main action method: create_virtualenv 13:48:00 INFO - Creating virtualenv /builds/slave/test/build/venv 13:48:00 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 13:48:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:48:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:48:00 INFO - Using real prefix '/usr' 13:48:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:48:01 INFO - Installing distribute.............................................................................................................................................................................................done. 13:48:03 INFO - Installing pip.................done. 13:48:03 INFO - Return code: 0 13:48:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:48:03 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')]} 13:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:03 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')]} 13:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:03 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:03 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 13:48:03 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 13:48:03 INFO - Using env: {'DISPLAY': ':0', 13:48:03 INFO - 'HOME': '/home/cltbld', 13:48:03 INFO - 'LANG': 'en_US.UTF-8', 13:48:03 INFO - 'LANGUAGE': 'en_US:en', 13:48:03 INFO - 'LOGNAME': 'cltbld', 13:48:03 INFO - 'MAIL': '/var/mail/cltbld', 13:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:03 INFO - 'MOZ_NO_REMOTE': '1', 13:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:03 INFO - 'NO_EM_RESTART': '1', 13:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:03 INFO - 'PWD': '/builds/slave/test', 13:48:03 INFO - 'SHELL': '/bin/bash', 13:48:03 INFO - 'SHLVL': '1', 13:48:03 INFO - 'TERM': 'linux', 13:48:03 INFO - 'TMOUT': '86400', 13:48:03 INFO - 'USER': 'cltbld', 13:48:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:03 INFO - '_': '/tools/buildbot/bin/python'} 13:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:03 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 13:48:03 INFO - Cleaning up... 13:48:03 INFO - Return code: 0 13:48:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:48:03 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')]} 13:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:03 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')]} 13:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:03 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:03 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 13:48:03 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 13:48:03 INFO - Using env: {'DISPLAY': ':0', 13:48:03 INFO - 'HOME': '/home/cltbld', 13:48:03 INFO - 'LANG': 'en_US.UTF-8', 13:48:03 INFO - 'LANGUAGE': 'en_US:en', 13:48:03 INFO - 'LOGNAME': 'cltbld', 13:48:03 INFO - 'MAIL': '/var/mail/cltbld', 13:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:03 INFO - 'MOZ_NO_REMOTE': '1', 13:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:03 INFO - 'NO_EM_RESTART': '1', 13:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:03 INFO - 'PWD': '/builds/slave/test', 13:48:03 INFO - 'SHELL': '/bin/bash', 13:48:03 INFO - 'SHLVL': '1', 13:48:03 INFO - 'TERM': 'linux', 13:48:03 INFO - 'TMOUT': '86400', 13:48:03 INFO - 'USER': 'cltbld', 13:48:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:03 INFO - '_': '/tools/buildbot/bin/python'} 13:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:03 INFO - Downloading/unpacking psutil>=3.1.1 13:48:03 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 13:48:03 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 13:48:03 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 13:48:03 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 13:48:03 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 13:48:03 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 13:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:05 INFO - Installing collected packages: psutil 13:48:05 INFO - Running setup.py install for psutil 13:48:05 INFO - building 'psutil._psutil_linux' extension 13:48:05 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 13:48:06 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 13:48:06 INFO - building 'psutil._psutil_posix' extension 13:48:06 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 13:48:06 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 13:48:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:06 INFO - Successfully installed psutil 13:48:06 INFO - Cleaning up... 13:48:06 INFO - Return code: 0 13:48:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:48: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')]} 13:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:48:06 INFO - Using env: {'DISPLAY': ':0', 13:48:06 INFO - 'HOME': '/home/cltbld', 13:48:06 INFO - 'LANG': 'en_US.UTF-8', 13:48:06 INFO - 'LANGUAGE': 'en_US:en', 13:48:06 INFO - 'LOGNAME': 'cltbld', 13:48:06 INFO - 'MAIL': '/var/mail/cltbld', 13:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:06 INFO - 'MOZ_NO_REMOTE': '1', 13:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:06 INFO - 'NO_EM_RESTART': '1', 13:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:06 INFO - 'PWD': '/builds/slave/test', 13:48:06 INFO - 'SHELL': '/bin/bash', 13:48:06 INFO - 'SHLVL': '1', 13:48:06 INFO - 'TERM': 'linux', 13:48:06 INFO - 'TMOUT': '86400', 13:48:06 INFO - 'USER': 'cltbld', 13:48:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:06 INFO - '_': '/tools/buildbot/bin/python'} 13:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:48:08 INFO - Installing collected packages: mozsystemmonitor 13:48:08 INFO - Running setup.py install for mozsystemmonitor 13:48:08 INFO - Successfully installed mozsystemmonitor 13:48:08 INFO - Cleaning up... 13:48:08 INFO - Return code: 0 13:48:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:08 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:08 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 13:48:08 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 13:48:08 INFO - Using env: {'DISPLAY': ':0', 13:48:08 INFO - 'HOME': '/home/cltbld', 13:48:08 INFO - 'LANG': 'en_US.UTF-8', 13:48:08 INFO - 'LANGUAGE': 'en_US:en', 13:48:08 INFO - 'LOGNAME': 'cltbld', 13:48:08 INFO - 'MAIL': '/var/mail/cltbld', 13:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:08 INFO - 'MOZ_NO_REMOTE': '1', 13:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:08 INFO - 'NO_EM_RESTART': '1', 13:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:08 INFO - 'PWD': '/builds/slave/test', 13:48:08 INFO - 'SHELL': '/bin/bash', 13:48:08 INFO - 'SHLVL': '1', 13:48:08 INFO - 'TERM': 'linux', 13:48:08 INFO - 'TMOUT': '86400', 13:48:08 INFO - 'USER': 'cltbld', 13:48:08 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:08 INFO - '_': '/tools/buildbot/bin/python'} 13:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:08 INFO - Downloading/unpacking jsonschema==2.5.1 13:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:48:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:48:10 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 13:48:10 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 13:48:10 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 13:48:10 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 13:48:10 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 13:48:10 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 13:48:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:48:11 INFO - warning: no files found matching '*.txt' 13:48:11 INFO - no previously-included directories found matching 'build' 13:48:11 INFO - no previously-included directories found matching 'dist' 13:48:11 INFO - no previously-included directories found matching '.git*' 13:48:11 INFO - Installing collected packages: jsonschema, functools32 13:48:11 INFO - Running setup.py install for functools32 13:48:11 INFO - warning: no files found matching '*.txt' 13:48:11 INFO - no previously-included directories found matching 'build' 13:48:11 INFO - no previously-included directories found matching 'dist' 13:48:11 INFO - no previously-included directories found matching '.git*' 13:48:11 INFO - Successfully installed jsonschema functools32 13:48:11 INFO - Cleaning up... 13:48:11 INFO - Return code: 0 13:48:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:48:11 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')]} 13:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:11 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')]} 13:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:11 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:11 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 13:48:11 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 13:48:11 INFO - Using env: {'DISPLAY': ':0', 13:48:11 INFO - 'HOME': '/home/cltbld', 13:48:11 INFO - 'LANG': 'en_US.UTF-8', 13:48:11 INFO - 'LANGUAGE': 'en_US:en', 13:48:11 INFO - 'LOGNAME': 'cltbld', 13:48:11 INFO - 'MAIL': '/var/mail/cltbld', 13:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:11 INFO - 'MOZ_NO_REMOTE': '1', 13:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:11 INFO - 'NO_EM_RESTART': '1', 13:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:11 INFO - 'PWD': '/builds/slave/test', 13:48:11 INFO - 'SHELL': '/bin/bash', 13:48:11 INFO - 'SHLVL': '1', 13:48:11 INFO - 'TERM': 'linux', 13:48:11 INFO - 'TMOUT': '86400', 13:48:11 INFO - 'USER': 'cltbld', 13:48:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:11 INFO - '_': '/tools/buildbot/bin/python'} 13:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:48:11 INFO - Cleaning up... 13:48:11 INFO - Return code: 0 13:48:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:48:11 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')]} 13:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:11 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')]} 13:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:11 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:11 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 13:48:11 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 13:48:11 INFO - Using env: {'DISPLAY': ':0', 13:48:11 INFO - 'HOME': '/home/cltbld', 13:48:11 INFO - 'LANG': 'en_US.UTF-8', 13:48:11 INFO - 'LANGUAGE': 'en_US:en', 13:48:11 INFO - 'LOGNAME': 'cltbld', 13:48:11 INFO - 'MAIL': '/var/mail/cltbld', 13:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:11 INFO - 'MOZ_NO_REMOTE': '1', 13:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:11 INFO - 'NO_EM_RESTART': '1', 13:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:11 INFO - 'PWD': '/builds/slave/test', 13:48:11 INFO - 'SHELL': '/bin/bash', 13:48:11 INFO - 'SHLVL': '1', 13:48:11 INFO - 'TERM': 'linux', 13:48:11 INFO - 'TMOUT': '86400', 13:48:11 INFO - 'USER': 'cltbld', 13:48:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:11 INFO - '_': '/tools/buildbot/bin/python'} 13:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:11 INFO - Downloading/unpacking blobuploader==1.2.4 13:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:13 INFO - Downloading blobuploader-1.2.4.tar.gz 13:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:48:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:48:13 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 13:48:13 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 13:48:13 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 13:48:13 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 13:48:13 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 13:48:13 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 13:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:48:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:14 INFO - Downloading docopt-0.6.1.tar.gz 13:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:48:14 INFO - Installing collected packages: blobuploader, requests, docopt 13:48:14 INFO - Running setup.py install for blobuploader 13:48:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:48:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:48:14 INFO - Running setup.py install for requests 13:48:14 INFO - Running setup.py install for docopt 13:48:14 INFO - Successfully installed blobuploader requests docopt 13:48:14 INFO - Cleaning up... 13:48:15 INFO - Return code: 0 13:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:15 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:15 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 13:48:15 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 13:48:15 INFO - Using env: {'DISPLAY': ':0', 13:48:15 INFO - 'HOME': '/home/cltbld', 13:48:15 INFO - 'LANG': 'en_US.UTF-8', 13:48:15 INFO - 'LANGUAGE': 'en_US:en', 13:48:15 INFO - 'LOGNAME': 'cltbld', 13:48:15 INFO - 'MAIL': '/var/mail/cltbld', 13:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:15 INFO - 'MOZ_NO_REMOTE': '1', 13:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:15 INFO - 'NO_EM_RESTART': '1', 13:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:15 INFO - 'PWD': '/builds/slave/test', 13:48:15 INFO - 'SHELL': '/bin/bash', 13:48:15 INFO - 'SHLVL': '1', 13:48:15 INFO - 'TERM': 'linux', 13:48:15 INFO - 'TMOUT': '86400', 13:48:15 INFO - 'USER': 'cltbld', 13:48:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:15 INFO - '_': '/tools/buildbot/bin/python'} 13:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:48:15 INFO - Running setup.py (path:/tmp/pip-9OI3lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:48:15 INFO - Running setup.py (path:/tmp/pip-31UT_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:48:15 INFO - Running setup.py (path:/tmp/pip-M4x4rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:48:15 INFO - Running setup.py (path:/tmp/pip-kDwj8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:48:15 INFO - Running setup.py (path:/tmp/pip-h7VsCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:48:15 INFO - Running setup.py (path:/tmp/pip-SpU538-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:48:15 INFO - Running setup.py (path:/tmp/pip-KDRm6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:48:15 INFO - Running setup.py (path:/tmp/pip-EJJpxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:48:15 INFO - Running setup.py (path:/tmp/pip-6bEbgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:48:15 INFO - Running setup.py (path:/tmp/pip-uCC_Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:48:15 INFO - Running setup.py (path:/tmp/pip-5uUbCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:48:16 INFO - Running setup.py (path:/tmp/pip-CYA59F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:48:16 INFO - Running setup.py (path:/tmp/pip-Wx4IQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:48:16 INFO - Running setup.py (path:/tmp/pip-wrLZdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:16 INFO - Running setup.py (path:/tmp/pip-xlBOtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:48:16 INFO - Running setup.py (path:/tmp/pip-YlqVSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:48:16 INFO - Running setup.py (path:/tmp/pip-Yd3udJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:48:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:48:16 INFO - Running setup.py install for manifestparser 13:48:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:48:16 INFO - Running setup.py install for mozcrash 13:48:16 INFO - Running setup.py install for mozdebug 13:48:16 INFO - Running setup.py install for mozdevice 13:48:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:48:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:48:16 INFO - Running setup.py install for mozfile 13:48:16 INFO - Running setup.py install for mozhttpd 13:48:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Running setup.py install for mozinfo 13:48:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Running setup.py install for mozInstall 13:48:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Running setup.py install for mozleak 13:48:17 INFO - Running setup.py install for mozlog 13:48:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Running setup.py install for moznetwork 13:48:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Running setup.py install for mozprocess 13:48:17 INFO - Running setup.py install for mozprofile 13:48:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Running setup.py install for mozrunner 13:48:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:48:17 INFO - Running setup.py install for mozscreenshot 13:48:18 INFO - Running setup.py install for moztest 13:48:18 INFO - Running setup.py install for mozversion 13:48:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:48:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:48:18 INFO - Cleaning up... 13:48:18 INFO - Return code: 0 13:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:18 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')]} 13:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:18 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')]} 13:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:18 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:18 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 13:48:18 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 13:48:18 INFO - Using env: {'DISPLAY': ':0', 13:48:18 INFO - 'HOME': '/home/cltbld', 13:48:18 INFO - 'LANG': 'en_US.UTF-8', 13:48:18 INFO - 'LANGUAGE': 'en_US:en', 13:48:18 INFO - 'LOGNAME': 'cltbld', 13:48:18 INFO - 'MAIL': '/var/mail/cltbld', 13:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:18 INFO - 'MOZ_NO_REMOTE': '1', 13:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:18 INFO - 'NO_EM_RESTART': '1', 13:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:18 INFO - 'PWD': '/builds/slave/test', 13:48:18 INFO - 'SHELL': '/bin/bash', 13:48:18 INFO - 'SHLVL': '1', 13:48:18 INFO - 'TERM': 'linux', 13:48:18 INFO - 'TMOUT': '86400', 13:48:18 INFO - 'USER': 'cltbld', 13:48:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:18 INFO - '_': '/tools/buildbot/bin/python'} 13:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:48:18 INFO - Running setup.py (path:/tmp/pip-GIRfls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:48:18 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)) 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:48:18 INFO - Running setup.py (path:/tmp/pip-49gdvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:48:18 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)) 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:48:18 INFO - Running setup.py (path:/tmp/pip-fGtGqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:48:18 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)) 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:48:18 INFO - Running setup.py (path:/tmp/pip-3l7c3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:48:18 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)) 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:48:18 INFO - Running setup.py (path:/tmp/pip-XIPPXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:48:18 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)) 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:48:18 INFO - Running setup.py (path:/tmp/pip-eLwpe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:48:18 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)) 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:48:18 INFO - Running setup.py (path:/tmp/pip-2YJPpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:48:18 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)) 13:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:48:18 INFO - Running setup.py (path:/tmp/pip-vyNl_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:48:19 INFO - Running setup.py (path:/tmp/pip-WNYJmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:48:19 INFO - Running setup.py (path:/tmp/pip-gkYmrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:48:19 INFO - Running setup.py (path:/tmp/pip-kzdpFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:48:19 INFO - Running setup.py (path:/tmp/pip-3Ziifj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:48:19 INFO - Running setup.py (path:/tmp/pip-QfjFS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:48:19 INFO - Running setup.py (path:/tmp/pip-AmH7fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:19 INFO - Running setup.py (path:/tmp/pip-hLHpjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:48:19 INFO - Running setup.py (path:/tmp/pip-LEkAGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:48:19 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)) 13:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:48:19 INFO - Running setup.py (path:/tmp/pip-QLspsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:48:19 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)) 13:48:19 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)) 13:48:19 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)) 13:48:19 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)) 13:48:19 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)) 13:48:19 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)) 13:48:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:21 INFO - Downloading blessings-1.6.tar.gz 13:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:48:21 INFO - Installing collected packages: blessings 13:48:21 INFO - Running setup.py install for blessings 13:48:21 INFO - Successfully installed blessings 13:48:21 INFO - Cleaning up... 13:48:21 INFO - Return code: 0 13:48:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:48:22 INFO - Reading from file tmpfile_stdout 13:48:22 INFO - Current package versions: 13:48:22 INFO - argparse == 1.2.1 13:48:22 INFO - blessings == 1.6 13:48:22 INFO - blobuploader == 1.2.4 13:48:22 INFO - docopt == 0.6.1 13:48:22 INFO - functools32 == 3.2.3-2 13:48:22 INFO - jsonschema == 2.5.1 13:48:22 INFO - manifestparser == 1.1 13:48:22 INFO - mozInstall == 1.12 13:48:22 INFO - mozcrash == 0.17 13:48:22 INFO - mozdebug == 0.1 13:48:22 INFO - mozdevice == 0.48 13:48:22 INFO - mozfile == 1.2 13:48:22 INFO - mozhttpd == 0.7 13:48:22 INFO - mozinfo == 0.9 13:48:22 INFO - mozleak == 0.1 13:48:22 INFO - mozlog == 3.3 13:48:22 INFO - moznetwork == 0.27 13:48:22 INFO - mozprocess == 0.23 13:48:22 INFO - mozprofile == 0.28 13:48:22 INFO - mozrunner == 6.12 13:48:22 INFO - mozscreenshot == 0.1 13:48:22 INFO - mozsystemmonitor == 0.3 13:48:22 INFO - moztest == 0.7 13:48:22 INFO - mozversion == 1.4 13:48:22 INFO - psutil == 3.1.1 13:48:22 INFO - requests == 1.2.3 13:48:22 INFO - wsgiref == 0.1.2 13:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 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 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:22 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 13:48:22 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 13:48:22 INFO - Using env: {'DISPLAY': ':0', 13:48:22 INFO - 'HOME': '/home/cltbld', 13:48:22 INFO - 'LANG': 'en_US.UTF-8', 13:48:22 INFO - 'LANGUAGE': 'en_US:en', 13:48:22 INFO - 'LOGNAME': 'cltbld', 13:48:22 INFO - 'MAIL': '/var/mail/cltbld', 13:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:22 INFO - 'MOZ_NO_REMOTE': '1', 13:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:22 INFO - 'NO_EM_RESTART': '1', 13:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:22 INFO - 'PWD': '/builds/slave/test', 13:48:22 INFO - 'SHELL': '/bin/bash', 13:48:22 INFO - 'SHLVL': '1', 13:48:22 INFO - 'TERM': 'linux', 13:48:22 INFO - 'TMOUT': '86400', 13:48:22 INFO - 'USER': 'cltbld', 13:48:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:22 INFO - '_': '/tools/buildbot/bin/python'} 13:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 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)) 13:48:22 INFO - Cleaning up... 13:48:22 INFO - Return code: 0 13:48:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, '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': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', '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 13:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:48:22 INFO - Using env: {'DISPLAY': ':0', 13:48:22 INFO - 'HOME': '/home/cltbld', 13:48:22 INFO - 'LANG': 'en_US.UTF-8', 13:48:22 INFO - 'LANGUAGE': 'en_US:en', 13:48:22 INFO - 'LOGNAME': 'cltbld', 13:48:22 INFO - 'MAIL': '/var/mail/cltbld', 13:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:22 INFO - 'MOZ_NO_REMOTE': '1', 13:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:22 INFO - 'NO_EM_RESTART': '1', 13:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:22 INFO - 'PWD': '/builds/slave/test', 13:48:22 INFO - 'SHELL': '/bin/bash', 13:48:22 INFO - 'SHLVL': '1', 13:48:22 INFO - 'TERM': 'linux', 13:48:22 INFO - 'TMOUT': '86400', 13:48:22 INFO - 'USER': 'cltbld', 13:48:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:22 INFO - '_': '/tools/buildbot/bin/python'} 13:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:48:22 INFO - Cleaning up... 13:48:22 INFO - Return code: 0 13:48:22 INFO - Running post-action listener: _resource_record_post_action 13:48:22 INFO - Running post-action listener: _start_resource_monitoring 13:48:22 INFO - Starting resource monitoring. 13:48:22 INFO - [mozharness: 2016-08-01 20:48:22.528725Z] Finished create-virtualenv step (success) 13:48:22 INFO - [mozharness: 2016-08-01 20:48:22.529149Z] Running install step. 13:48:22 INFO - Running pre-action listener: _resource_record_pre_action 13:48:22 INFO - Running main action method: install 13:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:48:22 INFO - Reading from file tmpfile_stdout 13:48:22 INFO - Detecting whether we're running mozinstall >=1.0... 13:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:48:22 INFO - Reading from file tmpfile_stdout 13:48:22 INFO - Output received: 13:48:22 INFO - Usage: mozinstall [options] installer 13:48:22 INFO - Options: 13:48:22 INFO - -h, --help show this help message and exit 13:48:22 INFO - -d DEST, --destination=DEST 13:48:22 INFO - Directory to install application into. [default: 13:48:22 INFO - "/builds/slave/test"] 13:48:22 INFO - --app=APP Application being installed. [default: firefox] 13:48:22 INFO - mkdir: /builds/slave/test/build/application 13:48:22 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'] 13:48:22 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 13:48:38 INFO - Reading from file tmpfile_stdout 13:48:38 INFO - Output received: 13:48:38 INFO - /builds/slave/test/build/application/firefox/firefox 13:48:38 INFO - Running post-action listener: _resource_record_post_action 13:48:38 INFO - [mozharness: 2016-08-01 20:48:38.838939Z] Finished install step (success) 13:48:38 INFO - [mozharness: 2016-08-01 20:48:38.839214Z] Running run-tests step. 13:48:38 INFO - Running pre-action listener: _resource_record_pre_action 13:48:38 INFO - Running main action method: run_tests 13:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:48:38 INFO - Python 2.7.3 13:48:38 INFO - Return code: 0 13:48:38 INFO - grabbing minidump binary from tooltool 13:48:38 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')]} 13:48:38 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 0x210b3b0>, '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 0x210c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:48:38 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 13:48:38 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 13:48:38 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 13:48:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:48:38 INFO - Return code: 0 13:48:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:48:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:48:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:48:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:48:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 13:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 13:48:38 INFO - Using env: {'DISPLAY': ':0', 13:48:38 INFO - 'HOME': '/home/cltbld', 13:48:38 INFO - 'LANG': 'en_US.UTF-8', 13:48:38 INFO - 'LANGUAGE': 'en_US:en', 13:48:38 INFO - 'LOGNAME': 'cltbld', 13:48:38 INFO - 'MAIL': '/var/mail/cltbld', 13:48:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:48:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:38 INFO - 'MOZ_NO_REMOTE': '1', 13:48:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:38 INFO - 'NO_EM_RESTART': '1', 13:48:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:38 INFO - 'PWD': '/builds/slave/test', 13:48:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:48:38 INFO - 'SHELL': '/bin/bash', 13:48:38 INFO - 'SHLVL': '1', 13:48:38 INFO - 'TERM': 'linux', 13:48:38 INFO - 'TMOUT': '86400', 13:48:38 INFO - 'USER': 'cltbld', 13:48:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441', 13:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:38 INFO - '_': '/tools/buildbot/bin/python'} 13:48:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 13:48:39 INFO - mozversion application_buildid: 20160801125249 13:48:39 INFO - mozversion application_changeset: e8b7e5dc300463a6bc5ecd5813329d6acce02982 13:48:39 INFO - mozversion application_display_name: Nightly 13:48:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:48:39 INFO - mozversion application_name: Firefox 13:48:39 INFO - mozversion application_remotingname: firefox 13:48:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:48:39 INFO - mozversion application_vendor: Mozilla 13:48:39 INFO - mozversion application_version: 50.0a1 13:48:39 INFO - mozversion platform_buildid: 20160801125249 13:48:39 INFO - mozversion platform_changeset: e8b7e5dc300463a6bc5ecd5813329d6acce02982 13:48:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:48:39 INFO - mozversion platform_version: 50.0a1 13:48:39 INFO - using testdate: 1470084519 13:48:39 INFO - actual date: 1470084519 13:48:39 INFO - starting webserver on 'localhost:56775' 13:48:39 INFO - SUITE-START | Running 2 tests 13:48:39 INFO - TEST-START | dromaeo_css 13:48:39 INFO - operating with platform_type : linux_ 13:48:39 INFO - Initialising browser for dromaeo_css test... 13:48:39 INFO - TEST-INFO | started process 9497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIhUqF/profile http://localhost:56775/getInfo.html) 13:48:43 INFO - PROCESS | 9497 | __metrics Screen width/height:1600/1200 13:48:43 INFO - PROCESS | 9497 | colorDepth:24 13:48:43 INFO - PROCESS | 9497 | Browser inner width/height: 1024/697 13:48:43 INFO - PROCESS | 9497 | __metrics 13:48:43 INFO - PROCESS | 9497 | 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" 13:48:43 INFO - PROCESS | 9497 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:48:44 INFO - TEST-INFO | 9497: exit 0 13:48:44 INFO - Browser initialized. 13:48:44 INFO - Running cycle 1/1 for dromaeo_css test... 13:48:44 INFO - TEST-INFO | started process 9572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIhUqF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:48:56 INFO - PROCESS | 9572 | RSS: Main: 157745152 13:48:56 INFO - PROCESS | 9572 | 13:49:49 INFO - PROCESS | 9572 | 1470084589196 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] 13:52:01 INFO - PROCESS | 9572 | Cycle 1(1): loaded http://localhost:56775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56775/tests/dromaeo/cssquery-ext.html) 13:52:02 INFO - PROCESS | 9572 | RSS: Main: 245800960 13:52:02 INFO - PROCESS | 9572 | 13:55:04 INFO - PROCESS | 9572 | Cycle 1(1): loaded http://localhost:56775/tests/dromaeo/cssquery-ext.html (next: http://localhost:56775/tests/dromaeo/cssquery-jquery.html) 13:55:05 INFO - PROCESS | 9572 | RSS: Main: 248598528 13:55:05 INFO - PROCESS | 9572 | 13:58:07 INFO - PROCESS | 9572 | Cycle 1(1): loaded http://localhost:56775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56775/tests/dromaeo/cssquery-mootools.html) 13:58:08 INFO - PROCESS | 9572 | RSS: Main: 191541248 13:58:08 INFO - PROCESS | 9572 | 14:01:10 INFO - PROCESS | 9572 | Cycle 1(1): loaded http://localhost:56775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56775/tests/dromaeo/cssquery-prototype.html) 14:01:11 INFO - PROCESS | 9572 | RSS: Main: 188088320 14:01:11 INFO - PROCESS | 9572 | 14:04:14 INFO - PROCESS | 9572 | Cycle 1(1): loaded http://localhost:56775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56775/tests/dromaeo/cssquery-yui.html) 14:04:14 INFO - PROCESS | 9572 | RSS: Main: 190107648 14:04:14 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | Cycle 1(1): loaded http://localhost:56775/tests/dromaeo/cssquery-yui.html (next: http://localhost:56775/tests/dromaeo/cssquery-dojo.html) 14:07:17 INFO - PROCESS | 9572 | RSS: Main: 272060416 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | __start_tp_report 14:07:17 INFO - PROCESS | 9572 | _x_x_mozilla_page_load 14:07:17 INFO - PROCESS | 9572 | _x_x_mozilla_page_load_details 14:07:17 INFO - PROCESS | 9572 | |i|pagename|runs| 14:07:17 INFO - PROCESS | 9572 | |0;dojo.html;2660.9068682596107;2667.0931883159724;2696.2046196372066;2696.797740169487;2708.7832973362133;4683.765811709418;4729.763511824408;4798.280257961307;4814.037192561488;4814.350062741529;4710.057988402316;4753.8811529711775;4776.068666610013;4776.092542416938;4830.082284365968;4368.039031413092;4375.846845360413;4447.866564003069;4501.527339629324;4536.931946020813;4452.688311818158;4481.977590112045;4498.50516443191;4502.48221454532;4509.165804326194;4326.610605045561;4348.4999225089205;4385.934210986838;4396.296592545209;4416.470023597157;4325.805338759764;4344.522102568715;4411.955880441186;4488.259437192859;4491.595756381908;4358.4987726411555;4360;4377.9343309850055;4408.801603927799;4409.338599210112;4526.34368016639;4737.999999999965;4795.904081918342;4803.591694705954;4806.158922188638;5066.138756411419;5122.564582010534;5128.794848206067;5140.820071297524;5207.505286997729;5153.149730294497;5189.506996835295;5218.243354713583;5218.452062533455;5231.24146998683;4686.976565117153;4742.881427964328;4863;4873.415190177201;4874.122657921573;5254.947450525522;5306.071437498499;5306.575473962151;5325.786968521215;5329.786808527616;5073.771680274396;5086;5088.618353623493;5105.183170692671;5134.2298655201275;4975.203967365276;5170.560502357266;5214.035403450298;5218.634695571273;5223.425423203445;5004.724740139254;5062.645614807002;5066.16408292635;5107.948920510822;5147.356580427447;5074.543291103744;5079.644424890296;5084.211947148198;5092.0579692756955;5144.279800827887;4236.76697781625;4365.716228445141;4370.519242883281;4376.431063961664;4436.290193569013;3696.8890933272046;3752.6059763724415;3792.544894612664;3815.6756675682323;3895.02624343914;4447.444069491314;4448.154850578379;4455.643548516111;4461.219286624828;4499.572540608637;5168.586513078944;5180.715060671624;5184.040952423814;5184.818531351385;5220.138677118233;4322.416473776063;4330.393744875657;4347.413099231627;4393.912121757611;4415.801288942005;4637.582617564368;4657.510961349009;4658.510856360033;4687.484376718558;4706.552877476634;4831.299461577981;4855.077535268288;4861.854144375674;4871.318015477907;4911.705297682151;4947.356843610308;5096.490350964874;5133.614978876524;5168.9741551292;5171.974140129275;4852.708837469763;4854.563089321978;4854.63590230727;4856.927146092741;4895.04546613407;5035.244713293036;5043.36957880265;5043.798248070183;5046.21783623539;5047.87380315495;4957.553820156203;5045.293658887832;5076.670016448919;5081.644284900021;5150.201718733602;4973.850784476472;4975.502449754996;4976.979719157636;4979.178435558092;4987.351644286219;4961.082199792905;4962.057209130254;4962.082014827269;4962.851114466572;4999.950000499948;4720.244760838249;4837.250226214942;4886.584640305614;4895.926561101515;4935.111679897509;5018.824341148043;5019.573336266459;5028.874278143076;5029.949700502948;5032.547070763649;4900.191468407673;4900.877478062935;4903.8528844134735;4905.8037678492465;4942.629302802232 14:07:17 INFO - PROCESS | 9572 | |1;ext.html;566.5382713088833;576.1415490918532;577.4571902411734;579.2585490572064;585.5608293779666;30356.24109397266;38654.61345386545;39734.99999999996;39791.204175916464;43492.565074349244;40208.39687404691;40775.79612101935;40787.38818917711;40825;40833;7587.165411804711;7716.382689384835;7721.806954826118;7724.536527808349;7726.38188944883;7358.337749602535;9551.713448596553;9769;9775.266854985868;10094.192464602851;10061.89938100617;10072.899271007305;10133;10159.288849780518;10160.94919525405;9963.651272205438;10001.949990250076;10034.297599168061;10040.297179197496;10057;9837.655682051094;9899.861515925688;9909.801803963952;9910.653127140587;9915.157211637019;37754.811225943966;38033.80983095067;38159.809200953816;38225.61774382276;38376;2988.2678743707716;3035.650900146489;3057.955345718558;3059.265776213693;3166.6200055993427;28962.42075158485;29520.704792952227;29832.403351933055;29865.25336866574;29933;3129.436701393748;3153.952690709641;3160.1625569223943;3251;3301.224212310105;251773;251832;251969;252338.73830630913;253135;31956;51998.22002669963;52399.47600524022;52454.47545524496;52512.737436313335;32032;32366.514502282484;32372.514412283836;32410.675893241238;32470;13584.184948903097;13678.726425471436;13696.794548081787;13708.314584270747;13717.314134293445;9461.337706360626;10919.071878890383;10956.34261944286;10965.780684386267;11197.104231661448;7658.65536050879;7837.373010159174;7909.881351779728;7916.802079947932;7921.564313962672;3102.4260511805387;3129.9201775387455;3147.3705258948303;3164.7784655074383;3167.5723777289772;726.4587882027923;736.694271877165;775.5153029356652;783.3733013589106;802.6548584108773;26896.32759181036;28990;29168.562471562942;29274.560881586793;29399.559006614916;952.3286083311249;985.2758222706306;992.5186284651938;1034.730969947804;1043.2436483549366;15176.392944282326;15200.163990980382;15228.543143705707;15285.541433757006;15312.387504499919;397787;399392;403373;405901;407166;50358.49641503538;50897.23654145191;50967;51005.23492147621;51073.233901491505;1047.790441911636;1166.900813430834;1188.6968822950266;1192.2250537150921;1200.2618389690451;25333.240002799947;29583.85208073946;29607;29705.25736856596;29893.252668682588;42442.57557424386;42668.359974599785;42764.358534622625;42819.785901070296;42862;296931;297602;298308;298442;299092;22286.554268914857;22992.08031678714;25332.240032799047;25748.8712556436;25863.612045819704;41420.1715965685;41913.79043104765;41934;45660.54339456696;46785.766071169426;35645.1088722784;35661.46507802437;35956.46065309075;36306.455403168446;36758.44862327014;35350.29299414049;36281.45577816388;36854;38199.80900095482;40381.192376151725;37283.81358093192;37680.24639507249;37914.24171516609;38691.613083868804;39269.6073039266;31001;33255.96159187414;33408.66591334153;33550.66449335475;33747.83126084452;25262;25429.74570254274;25497.61753573661;25505.61741573915;26173.607395888695 14:07:17 INFO - PROCESS | 9572 | |2;jquery.html;348.42683785173404;367.6158414456892;372.21276999146795;372.6031776158391;388.40767829060695;12594.307313097775;13227.338633068344;14845.480408185716;16808.831911680878;16823.66352672946;15939.362425502966;16594.17029148544;16951.745723814154;16980.915095424505;17026.318947242096;4925.556699897017;5117.488251174871;5122.462141475147;5134.383873935133;5142.07442660321;3802.144517483558;5691.3170419549715;6015.308239552463;6069;6097.725602347905;6000.879982400349;6004.849878753044;6009.609375390607;6057.363976782441;6765.391114799667;6907.689153988083;7093.432525397956;7107.46693997947;7112.182099058571;7112.39544638709;6636.8008959730805;6975.232724400312;7027.402670772939;7036.08530890986;7042.295770422917;22938.42653933665;23208;23653.290401287988;23766.405839853967;23896.88051559731;2008.096356639518;2044.7444069491314;2268.5803126421665;2455.8772061396858;2585.340738111788;13085.47658093675;14210.502632407815;14698.191599462025;15141.545753627408;15621.218939053002;1748.650269946016;1785.3126546279775;1921.634889371015;1961.9607607847906;1976.268780551191;77212.61393693052;79314.99999999942;80785;81059.5947020267;82130.58934705288;16337.509874703777;16470.42353517645;16711.582210444834;16988.405405810736;17152.742708859376;28906.855465722958;28951.42097158045;29087.709122908924;29229.7077029227;29392.26519336991;8489.193526614961;8720.912790872137;8767.693130740521;8891.91108088911;9066.048064953085;7106.395956343666;7157.284271572801;7168.641567921583;7333.413326933939;7360.116785985716;8138.43030987837;8301.252887240178;8346.123657015925;8444.831103377897;8463.195996380335;3116.4234616596004;3119.77437791698;3151.700588444094;3253.370845367609;3385.25524384635;797.1550156833774;825.2984962781587;853.2917678326974;860.3289434241302;909.1953621045291;16698.4155554555;16763.078030708428;17271.74092388615;17598.296068157386;17728.822711772977;805.6898094233645;811.736185739637;813.800618848386;824.5712229640553;828.1180542721982;7665.655045522964;9241.930501160961;9658.32391732586;9769.560369783378;9821.656242031495;377115;387000;387880;388731;389902;69513.65243173752;74259;75710.24289757032;76074;77467.61266193633;910.7040211931148;929.0523665860784;934.6448349627099;940.47333493244;948.9572969216401;14972.353041165681;15124.39502419935;15604;15702.842971570139;15835.208239588204;37684.811575941945;38055.80972095122;38236.235275294894;39011.659300442065;39292;51447.742761285954;51650.74174629103;52088.47911520836;52614.210786837466;53048;6215.34738852414;6869.828254293682;7433.1823499416105;7842.960785196037;8029.518228906284;8783.648654053766;11281.266717663326;11540.884591154318;11688.298702077902;11742.178047536932;9914.702558923243;9950.900490994998;10009.249306302203;10340;10453.68638940833;9463;9489.857652135086;9670.661526846527;9906.75233119149;10127.64553240633;9367.344285900193;9614.95192524033;9637.18083962843;10289.228307876789;10361.585536578452;7703.88444173349;7759.495632783851;7828.217178282126;7834.707273299841;8059.476134051268;7581;8949.373543852129;9904.603815847573;10031.498425078571;10320.12278956297 14:07:17 INFO - PROCESS | 9572 | |3;mootools.html;1223.8531376234853;1315.7763180259356;1365.975518361229;1414.1939094716015;1658.1626278729248;6097.939020609792;7008.929910700891;7351.632418379087;7360.30077142672;7368.078990126234;7045.89431158533;7164.391026762732;7195.6042417667;7350.08123984502;7366.116066072065;2184.355615093551;2241.204372447782;2243.3606422169687;2246.3485589179118;2247.045005872506;2167.967480487794;2218.500837311608;2223.899924503401;2228.576570451609;2228.888555572215;2150.4838838678684;2165.891705414731;2180.5420861619077;2182.432567532445;2184.7487538932987;2164.415607785897;2173.152470536492;2174.412908514708;2174.6737989301573;2174.8042676159143;2147.0874878176714;2186.6392045312505;2188.8577242479187;2189.6715492676226;2190.69330293759;7244.492885498017;7382.298681625237;7431.9256807431775;7452.850942981164;7475.364594009516;4467.865964021084;4669.533046695337;4674.7428891410955;4674.953250467486;4677.672562920597;2918.9270268243254;2992.085065558045;3048.786584939055;3054.373853360056;3060.785744997851;904.674317245791;907.1427501011547;916.9954150229273;918.5590916360118;928.772450749564;9998.550065247082;10218.591256349737;10233.181345492343;10235.027672371112;10235.641752538626;4074.103697186614;4096.651784598283;4246.256905041605;4252.234597772369;4298.376735373354;8726.912730872737;8733.083026282276;8803.031666516677;8814.206721394978;8824.470531768115;4639.605633521121;4648.2330415481065;4650.51169627191;4653.697509661861;4655.906881862344;3500.1949551603275;4043.2924238258774;4219.725717828332;4239.915201695949;4248.660107191417;3653.598104208535;3667.4132138857653;3789.962100379016;3798.1074447504816;3806.410006449005;1178.8938995490446;1220.7619514194823;1228.846394200725;1237.1958227152243;1240.6340129661771;813.8006188483741;832.5629044751432;836.8451836410284;865.6364326982682;878.4597472554461;5109.795608175631;5179.533841954167;5233.4243233244315;5391.083515802323;5471.644343117685;387.45369029668035;402.25984189092213;403.7093292829158;405.52148464811216;405.7585736486786;3529.7882127072457;3636.254567813592;3673.687736542424;3689.2068205335445;3783.981080094637;9136.58885350161;9375.10936461035;9395.248380129573;9449.858252126223;9455.621775129055;9333.859992100124;9401.670941517013;9415.717528474157;9420.95289523548;9424.528773561295;6942.548734332252;6994.790156295319;7113.110861142461;7124.323189297009;7222.205557388683;5307.4427185145005;5311.203319501951;5383.757730902197;5414.29614150158;5444.292242008513;8344.207300306462;8440.70457534008;8445.746627601182;8455.830883382421;8540.231379175904;8051.51690898548;8230.21812927771;8261.710840120568;8740.694075707319;8744.693935712474;5597.272354593877;6324.051392291193;6373.77691780804;6560.671966401565;6578.309277525982;6113.14415981754;6190.659513726789;6345.4923606112325;6352.047192920914;6358.713857876314;6238.875222495434;6475.805725828232;6487.481001519962;6498.707558159799;6658.201015878126;6260.843478913063;6352.237731472253;6417.422431981144;6485.513586480938;6540.444062254762;6250.406211409909;6290.119383286252;6316.652584107918;6323.652199129092;6348.555601107878;4473.150101480708;4578.10726908263;4600.861974140781;4712.552307530779;4909.754512274443;4576.4508259009135;4609.216433206296;4613.815447382067;4700.529947005272;4712.175369310426 14:07:17 INFO - PROCESS | 9572 | |4;prototype.html;288.98699558519866;289.74107502899903;290.32499438804786;299.13997257883585;305.7783107247245;4811.711297322163;4812.590929770974;4834;4841.322214889914;4851.58761505272;4709.411323584552;4741.8814529636775;4801.615870730342;4802.1836287831065;4807.807687692497;3603.7477376583715;3700.7409481336317;3701.2042410881654;3774.848336448226;3811;3807.5430948286244;3809;3819.503464549605;3833.5974722654137;3842.7895213007814;3761.1725420407465;3773.6037666063594;3778.1876896467256;3783.6783873370796;3783.924321513568;3591.838367273479;3624.0939765058733;3711.740178187528;3739.5886452490204;3744.700423966076;3308.106811160997;3309.8179600121985;3315.8673653053847;3319.850606722703;3328.417526932777;4612.146752850734;4654.2785868190485;4662.510436404196;4685.7657117144345;4690.812367505296;4154.563770804052;4259.637930775888;4262.211490874198;4285.764282964436;4290.442242508454;4922.852314430573;4951.43058548268;4963.379577552806;4965.9255111173;4966;3608;3616.801075940822;3618.3667858124986;3625.9456108158133;3632.529879681815;4954.281629163787;5234.973825130888;5276.419593844674;5284.180951952453;5285.814996475105;3555.6977656899453;3584.946225806615;3588.138846676831;3588.982055089708;3593.646161764049;3629.1471504196493;3633.3096711624707;3642.834293026206;3652.9817350913077;3656.908577285536;4206.621404073648;4209.2633789086785;4212.7682977435925;4213.536510983789;4219.9578004220175;4742.454617718938;5009.474005229398;5028.622853286018;5090.872728181825;5092.541671249605;1281.8974482041415;1295.8509771376223;1296.1898813241723;1297.5523444411663;1306.405585458614;806.246159840551;819.7253919936769;825.8348330333957;827.383599218586;870.277669534285;4369.388285640013;4413.874462012231;4424.358468022183;4440.4005459263235;4446.6220371268155;5072.898542029138;5090.720010399464;5092.745362731848;5095.566876815512;5096.796128154906;4314.158739045856;4400.031992961543;4438.755868427267;4439.378487011821;4448.843300741766;2703.6485256916476;2704.0400657766604;2704.78361731061;2705.809443844702;2714.80996330255;4818.132736107535;4818.903621927542;4821.156297647897;4825.396825396825;4836.443808961944;5065.493450654905;5096.566791822663;5187.896242075213;5197.636165468381;5239.423663397023;4800.1119792838435;4820.529738429743;4821.987382649612;4848.5636292733825;4852.902941941212;5064.746762661778;5073;5075.796968121382;5100.143919405145;5101.183810590288;4799.952000479951;4975.278584605139;5014.824481143142;5019.553784144245;5049.116404629249;4833.419989601271;4848.369711937426;4857.975710121426;4858.659893807399;4869.245266983623;3639.636036396339;3649.3978493548266;3649.470826730056;3650.0874781304674;3650.2516984018744;4873.805047798191;5097.617678674188;5124;5124.359455068116;5135.820246291362;4926.3349447824085;4941.110600092018;4943.332650092335;4956.645593343133;4961.05739909416;4944.826931057396;4951.653384263067;4953.603711702983;4968.975155124202;4969.552740253394;4618.214903466486;4836.540528649773;4868.440129385024;4871.098846713369;4871.634627402888;4782.976085119552;4879.414470263591;4945.208766597327;4947.851564453073;5021.799128034838;4926.556609905126;4944.4066711993355;4959;4962.900741985212;4967.950320496893 14:07:17 INFO - PROCESS | 9572 | |5;yui.html;603.5110668470262;626.3048016701462;640.6636515829186;693.3863530775262;705.7812078255741;12685.936570317148;13136;13638.454461821515;13832.446702131916;13852.58442246733;13327.933360333185;13639.93180034101;13642.590722278323;13644.72710545791;13669.11150775199;603.3182503770732;749.2208103572292;769.430621340207;771.7684694591628;772.0696560644438;746.8655641984441;762.6949220311864;762.9694812207533;773.7640019793961;774.8334108166744;806.681360862459;807.7617102954642;808.030363563723;808.6926967752246;808.7290757596212;631.6462780842743;805.279275048831;805.4482679364595;805.875089361147;807.0638059850575;566.2949627713523;575.8301301116181;578.9942100578983;584.1325631437312;584.9181114643953;13317.400716967759;13370.064095513319;13413.530526431528;13436.328183590782;13438.328083595781;12079.275243485332;12293.446794894251;12436.502539898393;12444.502219911192;12533.310667913353;9058.864117038249;9149.634014639407;9169.449833010041;9669.613215471372;12211.389430528527;4151.564085771011;4160.646345060673;4182;4190.413342132104;4257.276263035261;61073.69463152656;61779.69110154465;61908.38091619116;61973.380266197215;61988.99999999955;9033.322500812465;9257.953710231406;9642.276829237835;9967.850482242773;10037.297389182688;16882.493525194262;17020.829791701923;17049.31802727902;17102.48692539226;17113.144342782813;6888.862222755617;6924;6926.549774264657;7056.400205982446;7133.5719856808755;3530.152763336832;3626.274745050948;3729.869454569077;3810.6760925321105;3818.312703713358;2912.6504819421807;3026.7881248312847;3030.3181784098842;3047.360054388603;3049.8780048798244;496.1466278001831;504.70979186966906;508.3569284854662;510.3314657798296;517.0279873837162;446.19617758607484;499.1140725212704;591.5651995783096;596.1653684841257;603.1736520966305;7192.280771922766;7621;7625;7647.158812530728;8000.479968802009;577.6418620455345;592.8191901470007;597.7130977131002;605.8273392083236;605.9818205453844;3517.4150440051167;3666.74332796707;3667.3582123128344;3683.7605555638797;3762.830672619739;104476;105404;106701;109087.90912090936;109119;81973;85580;91858.54070729604;92366.53816730874;94886.52556737172;50129;59190.70404647949;71994;72970.27029729635;75859;7596.202398748273;8087.3125784308995;8181.427300088937;8190.385721070825;8243.175682431709;44254;44325.33511997258;44754.77622611866;45420.318695218935;45852.77073614744;51052.489475104776;61895.38104618896;62174.37825621867;62326.68836655788;64878.02682959854;9267.44395336282;9411.435313880915;9615.375000624937;9703.6118555257;10106.090451859369;11518.596849110241;11640.610284422772;11718;11817.172797904408;12057.939710301393;11083.612073577386;11181.105511559219;11346.262492938264;11722.296662200295;11767.470463829319;10896.12830973536;11433.371164586028;11759.647210583697;12107.394630268627;12132.575359862716;10719;10857.837132443177;11010.889891100986;11234.775304494027;11245.493952772309;9011.414258073204;9101.135392137736;9220;9324.347295689236;9414.19979301767;9063.68277110298;9105.954470227607;9115.817683646157;9620.801949933093;9710.660126895526 14:07:17 INFO - PROCESS | 9572 | __end_tp_report 14:07:17 INFO - PROCESS | 9572 | __start_cc_report 14:07:17 INFO - PROCESS | 9572 | _x_x_mozilla_cycle_collect,983 14:07:17 INFO - PROCESS | 9572 | __end_cc_report 14:07:17 INFO - PROCESS | 9572 | __startTimestamp1470085637908__endTimestamp 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | ------- Summary: start ------- 14:07:17 INFO - PROCESS | 9572 | Number of tests: 6 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | [#0] dojo.html Cycles:165 Average:4740.86 Median:4871.32 stddev:497.53 (10.2%) stddev-sans-first:471.54 14:07:17 INFO - PROCESS | 9572 | Values: 2660.9 2667.1 2696.2 2696.8 2708.8 4683.8 4729.8 4798.3 4814.0 4814.4 4710.1 4753.9 4776.1 4776.1 4830.1 4368.0 4375.8 4447.9 4501.5 4536.9 4452.7 4482.0 4498.5 4502.5 4509.2 4326.6 4348.5 4385.9 4396.3 4416.5 4325.8 4344.5 4412.0 4488.3 4491.6 4358.5 4360.0 4377.9 4408.8 4409.3 4526.3 4738.0 4795.9 4803.6 4806.2 5066.1 5122.6 5128.8 5140.8 5207.5 5153.1 5189.5 5218.2 5218.5 5231.2 4687.0 4742.9 4863.0 4873.4 4874.1 5254.9 5306.1 5306.6 5325.8 5329.8 5073.8 5086.0 5088.6 5105.2 5134.2 4975.2 5170.6 5214.0 5218.6 5223.4 5004.7 5062.6 5066.2 5107.9 5147.4 5074.5 5079.6 5084.2 5092.1 5144.3 4236.8 4365.7 4370.5 4376.4 4436.3 3696.9 3752.6 3792.5 3815.7 3895.0 4447.4 4448.2 4455.6 4461.2 4499.6 5168.6 5180.7 5184.0 5184.8 5220.1 4322.4 4330.4 4347.4 4393.9 4415.8 4637.6 4657.5 4658.5 4687.5 4706.6 4831.3 4855.1 4861.9 4871.3 4911.7 4947.4 5096.5 5133.6 5169.0 5172.0 4852.7 4854.6 4854.6 4856.9 4895.0 5035.2 5043.4 5043.8 5046.2 5047.9 4957.6 5045.3 5076.7 5081.6 5150.2 4973.9 4975.5 4977.0 4979.2 4987.4 4961.1 4962.1 4962.1 4962.9 5000.0 4720.2 4837.3 4886.6 4895.9 4935.1 5018.8 5019.6 5028.9 5029.9 5032.5 4900.2 4900.9 4903.9 4905.8 4942.6 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | [#1] ext.html Cycles:180 Average:46588.31 Median:33479.67 stddev:85383.81 (255.0%) stddev-sans-first:85553.42 14:07:17 INFO - PROCESS | 9572 | Values: 566.5 576.1 577.5 579.3 585.6 30356.2 38654.6 39735.0 39791.2 43492.6 40208.4 40775.8 40787.4 40825.0 40833.0 7587.2 7716.4 7721.8 7724.5 7726.4 7358.3 9551.7 9769.0 9775.3 10094.2 10061.9 10072.9 10133.0 10159.3 10160.9 9963.7 10001.9 10034.3 10040.3 10057.0 9837.7 9899.9 9909.8 9910.7 9915.2 37754.8 38033.8 38159.8 38225.6 38376.0 2988.3 3035.7 3058.0 3059.3 3166.6 28962.4 29520.7 29832.4 29865.3 29933.0 3129.4 3154.0 3160.2 3251.0 3301.2 251773.0 251832.0 251969.0 252338.7 253135.0 31956.0 51998.2 52399.5 52454.5 52512.7 32032.0 32366.5 32372.5 32410.7 32470.0 13584.2 13678.7 13696.8 13708.3 13717.3 9461.3 10919.1 10956.3 10965.8 11197.1 7658.7 7837.4 7909.9 7916.8 7921.6 3102.4 3129.9 3147.4 3164.8 3167.6 726.5 736.7 775.5 783.4 802.7 26896.3 28990.0 29168.6 29274.6 29399.6 952.3 985.3 992.5 1034.7 1043.2 15176.4 15200.2 15228.5 15285.5 15312.4 397787.0 399392.0 403373.0 405901.0 407166.0 50358.5 50897.2 50967.0 51005.2 51073.2 1047.8 1166.9 1188.7 1192.2 1200.3 25333.2 29583.9 29607.0 29705.3 29893.3 42442.6 42668.4 42764.4 42819.8 42862.0 296931.0 297602.0 298308.0 298442.0 299092.0 22286.6 22992.1 25332.2 25748.9 25863.6 41420.2 41913.8 41934.0 45660.5 46785.8 35645.1 35661.5 35956.5 36306.5 36758.4 35350.3 36281.5 36854.0 38199.8 40381.2 37283.8 37680.2 37914.2 38691.6 39269.6 31001.0 33256.0 33408.7 33550.7 33747.8 25262.0 25429.7 25497.6 25505.6 26173.6 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | [#2] jquery.html Cycles:180 Average:25540.92 Median:52351.34 stddev:63833.44 (121.9%) stddev-sans-first:63984.48 14:07:17 INFO - PROCESS | 9572 | Values: 348.4 367.6 372.2 372.6 388.4 12594.3 13227.3 14845.5 16808.8 16823.7 15939.4 16594.2 16951.7 16980.9 17026.3 4925.6 5117.5 5122.5 5134.4 5142.1 3802.1 5691.3 6015.3 6069.0 6097.7 6000.9 6004.8 6009.6 6057.4 6765.4 6907.7 7093.4 7107.5 7112.2 7112.4 6636.8 6975.2 7027.4 7036.1 7042.3 22938.4 23208.0 23653.3 23766.4 23896.9 2008.1 2044.7 2268.6 2455.9 2585.3 13085.5 14210.5 14698.2 15141.5 15621.2 1748.7 1785.3 1921.6 1962.0 1976.3 77212.6 79315.0 80785.0 81059.6 82130.6 16337.5 16470.4 16711.6 16988.4 17152.7 28906.9 28951.4 29087.7 29229.7 29392.3 8489.2 8720.9 8767.7 8891.9 9066.0 7106.4 7157.3 7168.6 7333.4 7360.1 8138.4 8301.3 8346.1 8444.8 8463.2 3116.4 3119.8 3151.7 3253.4 3385.3 797.2 825.3 853.3 860.3 909.2 16698.4 16763.1 17271.7 17598.3 17728.8 805.7 811.7 813.8 824.6 828.1 7665.7 9241.9 9658.3 9769.6 9821.7 377115.0 387000.0 387880.0 388731.0 389902.0 69513.7 74259.0 75710.2 76074.0 77467.6 910.7 929.1 934.6 940.5 949.0 14972.4 15124.4 15604.0 15702.8 15835.2 37684.8 38055.8 38236.2 39011.7 39292.0 51447.7 51650.7 52088.5 52614.2 53048.0 6215.3 6869.8 7433.2 7843.0 8029.5 8783.6 11281.3 11540.9 11688.3 11742.2 9914.7 9950.9 10009.2 10340.0 10453.7 9463.0 9489.9 9670.7 9906.8 10127.6 9367.3 9615.0 9637.2 10289.2 10361.6 7703.9 7759.5 7828.2 7834.7 8059.5 7581.0 8949.4 9904.6 10031.5 10320.1 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | [#3] mootools.html Cycles:180 Average:4964.11 Median:5206.48 stddev:2712.07 (52.1%) stddev-sans-first:2705.11 14:07:17 INFO - PROCESS | 9572 | Values: 1223.9 1315.8 1366.0 1414.2 1658.2 6097.9 7008.9 7351.6 7360.3 7368.1 7045.9 7164.4 7195.6 7350.1 7366.1 2184.4 2241.2 2243.4 2246.3 2247.0 2168.0 2218.5 2223.9 2228.6 2228.9 2150.5 2165.9 2180.5 2182.4 2184.7 2164.4 2173.2 2174.4 2174.7 2174.8 2147.1 2186.6 2188.9 2189.7 2190.7 7244.5 7382.3 7431.9 7452.9 7475.4 4467.9 4669.5 4674.7 4675.0 4677.7 2918.9 2992.1 3048.8 3054.4 3060.8 904.7 907.1 917.0 918.6 928.8 9998.6 10218.6 10233.2 10235.0 10235.6 4074.1 4096.7 4246.3 4252.2 4298.4 8726.9 8733.1 8803.0 8814.2 8824.5 4639.6 4648.2 4650.5 4653.7 4655.9 3500.2 4043.3 4219.7 4239.9 4248.7 3653.6 3667.4 3790.0 3798.1 3806.4 1178.9 1220.8 1228.8 1237.2 1240.6 813.8 832.6 836.8 865.6 878.5 5109.8 5179.5 5233.4 5391.1 5471.6 387.5 402.3 403.7 405.5 405.8 3529.8 3636.3 3673.7 3689.2 3784.0 9136.6 9375.1 9395.2 9449.9 9455.6 9333.9 9401.7 9415.7 9421.0 9424.5 6942.5 6994.8 7113.1 7124.3 7222.2 5307.4 5311.2 5383.8 5414.3 5444.3 8344.2 8440.7 8445.7 8455.8 8540.2 8051.5 8230.2 8261.7 8740.7 8744.7 5597.3 6324.1 6373.8 6560.7 6578.3 6113.1 6190.7 6345.5 6352.0 6358.7 6238.9 6475.8 6487.5 6498.7 6658.2 6260.8 6352.2 6417.4 6485.5 6540.4 6250.4 6290.1 6316.7 6323.7 6348.6 4473.2 4578.1 4600.9 4712.6 4909.8 4576.5 4609.2 4613.8 4700.5 4712.2 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | [#4] prototype.html Cycles:180 Average:4141.87 Median:4800.03 stddev:1194.27 (24.9%) stddev-sans-first:1162.08 14:07:17 INFO - PROCESS | 9572 | Values: 289.0 289.7 290.3 299.1 305.8 4811.7 4812.6 4834.0 4841.3 4851.6 4709.4 4741.9 4801.6 4802.2 4807.8 3603.7 3700.7 3701.2 3774.8 3811.0 3807.5 3809.0 3819.5 3833.6 3842.8 3761.2 3773.6 3778.2 3783.7 3783.9 3591.8 3624.1 3711.7 3739.6 3744.7 3308.1 3309.8 3315.9 3319.9 3328.4 4612.1 4654.3 4662.5 4685.8 4690.8 4154.6 4259.6 4262.2 4285.8 4290.4 4922.9 4951.4 4963.4 4965.9 4966.0 3608.0 3616.8 3618.4 3625.9 3632.5 4954.3 5235.0 5276.4 5284.2 5285.8 3555.7 3584.9 3588.1 3589.0 3593.6 3629.1 3633.3 3642.8 3653.0 3656.9 4206.6 4209.3 4212.8 4213.5 4220.0 4742.5 5009.5 5028.6 5090.9 5092.5 1281.9 1295.9 1296.2 1297.6 1306.4 806.2 819.7 825.8 827.4 870.3 4369.4 4413.9 4424.4 4440.4 4446.6 5072.9 5090.7 5092.7 5095.6 5096.8 4314.2 4400.0 4438.8 4439.4 4448.8 2703.6 2704.0 2704.8 2705.8 2714.8 4818.1 4818.9 4821.2 4825.4 4836.4 5065.5 5096.6 5187.9 5197.6 5239.4 4800.1 4820.5 4822.0 4848.6 4852.9 5064.7 5073.0 5075.8 5100.1 5101.2 4800.0 4975.3 5014.8 5019.6 5049.1 4833.4 4848.4 4858.0 4858.7 4869.2 3639.6 3649.4 3649.5 3650.1 3650.3 4873.8 5097.6 5124.0 5124.4 5135.8 4926.3 4941.1 4943.3 4956.6 4961.1 4944.8 4951.7 4953.6 4969.0 4969.6 4618.2 4836.5 4868.4 4871.1 4871.6 4783.0 4879.4 4945.2 4947.9 5021.8 4926.6 4944.4 4959.0 4962.9 4968.0 14:07:17 INFO - PROCESS | 9572 | 14:07:17 INFO - PROCESS | 9572 | [#5] yui.html Cycles:180 Average:17663.47 Median:581.56 stddev:26095.76 (4487.2%) stddev-sans-first:26137.53 14:07:17 INFO - PROCESS | 9572 | Values: 603.5 626.3 640.7 693.4 705.8 12685.9 13136.0 13638.5 13832.4 13852.6 13327.9 13639.9 13642.6 13644.7 13669.1 603.3 749.2 769.4 771.8 772.1 746.9 762.7 763.0 773.8 774.8 806.7 807.8 808.0 808.7 808.7 631.6 805.3 805.4 805.9 807.1 566.3 575.8 579.0 584.1 584.9 13317.4 13370.1 13413.5 13436.3 13438.3 12079.3 12293.4 12436.5 12444.5 12533.3 9058.9 9149.6 9169.4 9669.6 12211.4 4151.6 4160.6 4182.0 4190.4 4257.3 61073.7 61779.7 61908.4 61973.4 61989.0 9033.3 9258.0 9642.3 9967.9 10037.3 16882.5 17020.8 17049.3 17102.5 17113.1 6888.9 6924.0 6926.5 7056.4 7133.6 3530.2 3626.3 3729.9 3810.7 3818.3 2912.7 3026.8 3030.3 3047.4 3049.9 496.1 504.7 508.4 510.3 517.0 446.2 499.1 591.6 596.2 603.2 7192.3 7621.0 7625.0 7647.2 8000.5 577.6 592.8 597.7 605.8 606.0 3517.4 3666.7 3667.4 3683.8 3762.8 104476.0 105404.0 106701.0 109087.9 109119.0 81973.0 85580.0 91858.5 92366.5 94886.5 50129.0 59190.7 71994.0 72970.3 75859.0 7596.2 8087.3 8181.4 8190.4 8243.2 44254.0 44325.3 44754.8 45420.3 45852.8 51052.5 61895.4 62174.4 62326.7 64878.0 9267.4 9411.4 9615.4 9703.6 10106.1 11518.6 11640.6 11718.0 11817.2 12057.9 11083.6 11181.1 11346.3 11722.3 11767.5 10896.1 11433.4 11759.6 12107.4 12132.6 10719.0 10857.8 11010.9 11234.8 11245.5 9011.4 9101.1 9220.0 9324.3 9414.2 9063.7 9106.0 9115.8 9620.8 9710.7 14:07:17 INFO - PROCESS | 9572 | -------- Summary: end -------- 14:07:17 INFO - PROCESS | 9572 | 14:07:18 INFO - TEST-INFO | 9572: exit 0 14:07:18 INFO - TEST-OK | dromaeo_css | took 1119546ms 14:07:18 INFO - TEST-START | kraken 14:07:18 INFO - operating with platform_type : linux_ 14:07:18 INFO - Initialising browser for kraken test... 14:07:18 INFO - TEST-INFO | started process 9757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcNTGd/profile http://localhost:56775/getInfo.html) 14:07:22 INFO - PROCESS | 9757 | __metrics Screen width/height:1600/1200 14:07:22 INFO - PROCESS | 9757 | colorDepth:24 14:07:22 INFO - PROCESS | 9757 | Browser inner width/height: 1024/697 14:07:22 INFO - PROCESS | 9757 | __metrics 14:07:23 INFO - PROCESS | 9757 | 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" 14:07:23 INFO - PROCESS | 9757 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:07:24 INFO - TEST-INFO | 9757: exit 0 14:07:24 INFO - Browser initialized. 14:07:24 INFO - Running cycle 1/1 for kraken test... 14:07:24 INFO - TEST-INFO | started process 9838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcNTGd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:36 INFO - PROCESS | 9838 | RSS: Main: 157036544 14:07:36 INFO - PROCESS | 9838 | 14:07:38 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56775/tests/kraken/driver.html?testName=audio-beat-detection) 14:07:39 INFO - PROCESS | 9838 | RSS: Main: 213426176 14:07:39 INFO - PROCESS | 9838 | 14:07:42 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56775/tests/kraken/driver.html?testName=audio-dft) 14:07:43 INFO - PROCESS | 9838 | RSS: Main: 191500288 14:07:43 INFO - PROCESS | 9838 | 14:07:46 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56775/tests/kraken/driver.html?testName=audio-fft) 14:07:47 INFO - PROCESS | 9838 | RSS: Main: 271446016 14:07:47 INFO - PROCESS | 9838 | 14:07:49 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56775/tests/kraken/driver.html?testName=audio-oscillator) 14:07:49 INFO - PROCESS | 9838 | RSS: Main: 180240384 14:07:49 INFO - PROCESS | 9838 | 14:07:52 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:07:52 INFO - PROCESS | 9838 | RSS: Main: 185040896 14:07:52 INFO - PROCESS | 9838 | 14:07:55 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56775/tests/kraken/driver.html?testName=imaging-darkroom) 14:07:56 INFO - PROCESS | 9838 | RSS: Main: 221491200 14:07:56 INFO - PROCESS | 9838 | 14:07:59 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56775/tests/kraken/driver.html?testName=imaging-desaturate) 14:08:00 INFO - PROCESS | 9838 | RSS: Main: 220803072 14:08:00 INFO - PROCESS | 9838 | 14:08:03 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56775/tests/kraken/driver.html?testName=json-parse-financial) 14:08:04 INFO - PROCESS | 9838 | RSS: Main: 220614656 14:08:04 INFO - PROCESS | 9838 | 14:08:05 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:08:06 INFO - PROCESS | 9838 | RSS: Main: 185024512 14:08:06 INFO - PROCESS | 9838 | 14:08:08 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:08:08 INFO - PROCESS | 9838 | RSS: Main: 191033344 14:08:08 INFO - PROCESS | 9838 | 14:08:10 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:08:11 INFO - PROCESS | 9838 | RSS: Main: 195764224 14:08:11 INFO - PROCESS | 9838 | 14:08:14 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:08:15 INFO - PROCESS | 9838 | RSS: Main: 190427136 14:08:15 INFO - PROCESS | 9838 | 14:08:17 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:08:18 INFO - PROCESS | 9838 | RSS: Main: 193646592 14:08:18 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | Cycle 1(1): loaded http://localhost:56775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56775/tests/kraken/driver.html?testName=ai-astar) 14:08:20 INFO - PROCESS | 9838 | RSS: Main: 244465664 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | __start_tp_report 14:08:20 INFO - PROCESS | 9838 | _x_x_mozilla_page_load 14:08:20 INFO - PROCESS | 9838 | _x_x_mozilla_page_load_details 14:08:20 INFO - PROCESS | 9838 | |i|pagename|runs| 14:08:20 INFO - PROCESS | 9838 | |0;ai-astar;103;114;114;113;115;115;114;112;114;113 14:08:20 INFO - PROCESS | 9838 | |1;audio-beat-detection;147;127;123;182;122;123;151;121;160;126 14:08:20 INFO - PROCESS | 9838 | |2;audio-dft;162;161;161;161;161;161;160;160;159;160 14:08:20 INFO - PROCESS | 9838 | |3;audio-fft;76;76;75;114;76;77;77;75;101;76 14:08:20 INFO - PROCESS | 9838 | |4;audio-oscillator;85;87;111;85;86;84;117;85;86;133 14:08:20 INFO - PROCESS | 9838 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 14:08:20 INFO - PROCESS | 9838 | |6;imaging-darkroom;146;146;147;146;147;146;146;147;148;148 14:08:20 INFO - PROCESS | 9838 | |7;imaging-desaturate;96;95;95;95;95;94;95;96;95;95 14:08:20 INFO - PROCESS | 9838 | |8;json-parse-financial;62;62;62;61;62;61;62;62;61;61 14:08:20 INFO - PROCESS | 9838 | |9;json-stringify-tinderbox;64;65;66;65;66;65;65;67;66;66 14:08:20 INFO - PROCESS | 9838 | |10;stanford-crypto-aes;79;81;80;89;82;79;79;79;89;83 14:08:20 INFO - PROCESS | 9838 | |11;stanford-crypto-ccm;129;130;130;139;141;130;130;143;177;140 14:08:20 INFO - PROCESS | 9838 | |12;stanford-crypto-pbkdf2;172;169;164;166;164;162;167;171;168;168 14:08:20 INFO - PROCESS | 9838 | |13;stanford-crypto-sha256-iterative;69;68;67;68;68;68;66;67;67;67 14:08:20 INFO - PROCESS | 9838 | __end_tp_report 14:08:20 INFO - PROCESS | 9838 | __start_cc_report 14:08:20 INFO - PROCESS | 9838 | _x_x_mozilla_cycle_collect,1922 14:08:20 INFO - PROCESS | 9838 | __end_cc_report 14:08:20 INFO - PROCESS | 9838 | __startTimestamp1470085700540__endTimestamp 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | ------- Summary: start ------- 14:08:20 INFO - PROCESS | 9838 | Number of tests: 14 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.53 (3.1%) stddev-sans-first:0.97 14:08:20 INFO - PROCESS | 9838 | Values: 103.0 114.0 114.0 113.0 115.0 115.0 114.0 112.0 114.0 113.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:137.00 stddev:20.90 (15.3%) stddev-sans-first:21.92 14:08:20 INFO - PROCESS | 9838 | Values: 147.0 127.0 123.0 182.0 122.0 123.0 151.0 121.0 160.0 126.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.73 14:08:20 INFO - PROCESS | 9838 | Values: 162.0 161.0 161.0 161.0 161.0 161.0 160.0 160.0 159.0 160.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.65 (18.0%) stddev-sans-first:14.28 14:08:20 INFO - PROCESS | 9838 | Values: 76.0 76.0 75.0 114.0 76.0 77.0 77.0 75.0 101.0 76.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.71 (20.8%) stddev-sans-first:18.34 14:08:20 INFO - PROCESS | 9838 | Values: 85.0 87.0 111.0 85.0 86.0 84.0 117.0 85.0 86.0 133.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:08:20 INFO - PROCESS | 9838 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 14:08:20 INFO - PROCESS | 9838 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 148.0 148.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 14:08:20 INFO - PROCESS | 9838 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:08:20 INFO - PROCESS | 9838 | Values: 62.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 61.0 61.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 14:08:20 INFO - PROCESS | 9838 | Values: 64.0 65.0 66.0 65.0 66.0 65.0 65.0 67.0 66.0 66.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.94 (4.8%) stddev-sans-first:4.03 14:08:20 INFO - PROCESS | 9838 | Values: 79.0 81.0 80.0 89.0 82.0 79.0 79.0 79.0 89.0 83.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:139.50 stddev:14.49 (10.4%) stddev-sans-first:14.92 14:08:20 INFO - PROCESS | 9838 | Values: 129.0 130.0 130.0 139.0 141.0 130.0 130.0 143.0 177.0 140.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:3.18 (1.9%) stddev-sans-first:2.83 14:08:20 INFO - PROCESS | 9838 | Values: 172.0 169.0 164.0 166.0 164.0 162.0 167.0 171.0 168.0 168.0 14:08:20 INFO - PROCESS | 9838 | 14:08:20 INFO - PROCESS | 9838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 14:08:20 INFO - PROCESS | 9838 | Values: 69.0 68.0 67.0 68.0 68.0 68.0 66.0 67.0 67.0 67.0 14:08:20 INFO - PROCESS | 9838 | -------- Summary: end -------- 14:08:20 INFO - PROCESS | 9838 | 14:08:21 INFO - TEST-INFO | 9838: exit 0 14:08:21 INFO - TEST-OK | kraken | took 62999ms 14:08:21 INFO - SUITE-END | took 1182s 14:08:21 INFO - Completed test suite (00:19:42) 14:08:21 INFO - javascript benchmark 14:08:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.9068682596107, 2667.0931883159724, 2696.2046196372066, 2696.797740169487, 2708.7832973362133, 4683.765811709418, 4729.763511824408, 4798.280257961307, 4814.037192561488, 4814.350062741529, 4710.057988402316, 4753.8811529711775, 4776.068666610013, 4776.092542416938, 4830.082284365968, 4368.039031413092, 4375.846845360413, 4447.866564003069, 4501.527339629324, 4536.931946020813, 4452.688311818158, 4481.977590112045, 4498.50516443191, 4502.48221454532, 4509.165804326194, 4326.610605045561, 4348.4999225089205, 4385.934210986838, 4396.296592545209, 4416.470023597157, 4325.805338759764, 4344.522102568715, 4411.955880441186, 4488.259437192859, 4491.595756381908, 4358.4987726411555, 4360.0, 4377.9343309850055, 4408.801603927799, 4409.338599210112, 4526.34368016639, 4737.999999999965, 4795.904081918342, 4803.591694705954, 4806.158922188638, 5066.138756411419, 5122.564582010534, 5128.794848206067, 5140.820071297524, 5207.505286997729, 5153.149730294497, 5189.506996835295, 5218.243354713583, 5218.452062533455, 5231.24146998683, 4686.976565117153, 4742.881427964328, 4863.0, 4873.415190177201, 4874.122657921573, 5254.947450525522, 5306.071437498499, 5306.575473962151, 5325.786968521215, 5329.786808527616, 5073.771680274396, 5086.0, 5088.618353623493, 5105.183170692671, 5134.2298655201275, 4975.203967365276, 5170.560502357266, 5214.035403450298, 5218.634695571273, 5223.425423203445, 5004.724740139254, 5062.645614807002, 5066.16408292635, 5107.948920510822, 5147.356580427447, 5074.543291103744, 5079.644424890296, 5084.211947148198, 5092.0579692756955, 5144.279800827887, 4236.76697781625, 4365.716228445141, 4370.519242883281, 4376.431063961664, 4436.290193569013, 3696.8890933272046, 3752.6059763724415, 3792.544894612664, 3815.6756675682323, 3895.02624343914, 4447.444069491314, 4448.154850578379, 4455.643548516111, 4461.219286624828, 4499.572540608637, 5168.586513078944, 5180.715060671624, 5184.040952423814, 5184.818531351385, 5220.138677118233, 4322.416473776063, 4330.393744875657, 4347.413099231627, 4393.912121757611, 4415.801288942005, 4637.582617564368, 4657.510961349009, 4658.510856360033, 4687.484376718558, 4706.552877476634, 4831.299461577981, 4855.077535268288, 4861.854144375674, 4871.318015477907, 4911.705297682151, 4947.356843610308, 5096.490350964874, 5133.614978876524, 5168.9741551292, 5171.974140129275, 4852.708837469763, 4854.563089321978, 4854.63590230727, 4856.927146092741, 4895.04546613407, 5035.244713293036, 5043.36957880265, 5043.798248070183, 5046.21783623539, 5047.87380315495, 4957.553820156203, 5045.293658887832, 5076.670016448919, 5081.644284900021, 5150.201718733602, 4973.850784476472, 4975.502449754996, 4976.979719157636, 4979.178435558092, 4987.351644286219, 4961.082199792905, 4962.057209130254, 4962.082014827269, 4962.851114466572, 4999.950000499948, 4720.244760838249, 4837.250226214942, 4886.584640305614, 4895.926561101515, 4935.111679897509, 5018.824341148043, 5019.573336266459, 5028.874278143076, 5029.949700502948, 5032.547070763649, 4900.191468407673, 4900.877478062935, 4903.8528844134735, 4905.8037678492465, 4942.629302802232], "value": 4709.151414848519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.5382713088833, 576.1415490918532, 577.4571902411734, 579.2585490572064, 585.5608293779666, 30356.24109397266, 38654.61345386545, 39734.99999999996, 39791.204175916464, 43492.565074349244, 40208.39687404691, 40775.79612101935, 40787.38818917711, 40825.0, 40833.0, 7587.165411804711, 7716.382689384835, 7721.806954826118, 7724.536527808349, 7726.38188944883, 7358.337749602535, 9551.713448596553, 9769.0, 9775.266854985868, 10094.192464602851, 10061.89938100617, 10072.899271007305, 10133.0, 10159.288849780518, 10160.94919525405, 9963.651272205438, 10001.949990250076, 10034.297599168061, 10040.297179197496, 10057.0, 9837.655682051094, 9899.861515925688, 9909.801803963952, 9910.653127140587, 9915.157211637019, 37754.811225943966, 38033.80983095067, 38159.809200953816, 38225.61774382276, 38376.0, 2988.2678743707716, 3035.650900146489, 3057.955345718558, 3059.265776213693, 3166.6200055993427, 28962.42075158485, 29520.704792952227, 29832.403351933055, 29865.25336866574, 29933.0, 3129.436701393748, 3153.952690709641, 3160.1625569223943, 3251.0, 3301.224212310105, 251773.0, 251832.0, 251969.0, 252338.73830630913, 253135.0, 31956.0, 51998.22002669963, 52399.47600524022, 52454.47545524496, 52512.737436313335, 32032.0, 32366.514502282484, 32372.514412283836, 32410.675893241238, 32470.0, 13584.184948903097, 13678.726425471436, 13696.794548081787, 13708.314584270747, 13717.314134293445, 9461.337706360626, 10919.071878890383, 10956.34261944286, 10965.780684386267, 11197.104231661448, 7658.65536050879, 7837.373010159174, 7909.881351779728, 7916.802079947932, 7921.564313962672, 3102.4260511805387, 3129.9201775387455, 3147.3705258948303, 3164.7784655074383, 3167.5723777289772, 726.4587882027923, 736.694271877165, 775.5153029356652, 783.3733013589106, 802.6548584108773, 26896.32759181036, 28990.0, 29168.562471562942, 29274.560881586793, 29399.559006614916, 952.3286083311249, 985.2758222706306, 992.5186284651938, 1034.730969947804, 1043.2436483549366, 15176.392944282326, 15200.163990980382, 15228.543143705707, 15285.541433757006, 15312.387504499919, 397787.0, 399392.0, 403373.0, 405901.0, 407166.0, 50358.49641503538, 50897.23654145191, 50967.0, 51005.23492147621, 51073.233901491505, 1047.790441911636, 1166.900813430834, 1188.6968822950266, 1192.2250537150921, 1200.2618389690451, 25333.240002799947, 29583.85208073946, 29607.0, 29705.25736856596, 29893.252668682588, 42442.57557424386, 42668.359974599785, 42764.358534622625, 42819.785901070296, 42862.0, 296931.0, 297602.0, 298308.0, 298442.0, 299092.0, 22286.554268914857, 22992.08031678714, 25332.240032799047, 25748.8712556436, 25863.612045819704, 41420.1715965685, 41913.79043104765, 41934.0, 45660.54339456696, 46785.766071169426, 35645.1088722784, 35661.46507802437, 35956.46065309075, 36306.455403168446, 36758.44862327014, 35350.29299414049, 36281.45577816388, 36854.0, 38199.80900095482, 40381.192376151725, 37283.81358093192, 37680.24639507249, 37914.24171516609, 38691.613083868804, 39269.6073039266, 31001.0, 33255.96159187414, 33408.66591334153, 33550.66449335475, 33747.83126084452, 25262.0, 25429.74570254274, 25497.61753573661, 25505.61741573915, 26173.607395888695], "value": 16832.120489865178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.42683785173404, 367.6158414456892, 372.21276999146795, 372.6031776158391, 388.40767829060695, 12594.307313097775, 13227.338633068344, 14845.480408185716, 16808.831911680878, 16823.66352672946, 15939.362425502966, 16594.17029148544, 16951.745723814154, 16980.915095424505, 17026.318947242096, 4925.556699897017, 5117.488251174871, 5122.462141475147, 5134.383873935133, 5142.07442660321, 3802.144517483558, 5691.3170419549715, 6015.308239552463, 6069.0, 6097.725602347905, 6000.879982400349, 6004.849878753044, 6009.609375390607, 6057.363976782441, 6765.391114799667, 6907.689153988083, 7093.432525397956, 7107.46693997947, 7112.182099058571, 7112.39544638709, 6636.8008959730805, 6975.232724400312, 7027.402670772939, 7036.08530890986, 7042.295770422917, 22938.42653933665, 23208.0, 23653.290401287988, 23766.405839853967, 23896.88051559731, 2008.096356639518, 2044.7444069491314, 2268.5803126421665, 2455.8772061396858, 2585.340738111788, 13085.47658093675, 14210.502632407815, 14698.191599462025, 15141.545753627408, 15621.218939053002, 1748.650269946016, 1785.3126546279775, 1921.634889371015, 1961.9607607847906, 1976.268780551191, 77212.61393693052, 79314.99999999942, 80785.0, 81059.5947020267, 82130.58934705288, 16337.509874703777, 16470.42353517645, 16711.582210444834, 16988.405405810736, 17152.742708859376, 28906.855465722958, 28951.42097158045, 29087.709122908924, 29229.7077029227, 29392.26519336991, 8489.193526614961, 8720.912790872137, 8767.693130740521, 8891.91108088911, 9066.048064953085, 7106.395956343666, 7157.284271572801, 7168.641567921583, 7333.413326933939, 7360.116785985716, 8138.43030987837, 8301.252887240178, 8346.123657015925, 8444.831103377897, 8463.195996380335, 3116.4234616596004, 3119.77437791698, 3151.700588444094, 3253.370845367609, 3385.25524384635, 797.1550156833774, 825.2984962781587, 853.2917678326974, 860.3289434241302, 909.1953621045291, 16698.4155554555, 16763.078030708428, 17271.74092388615, 17598.296068157386, 17728.822711772977, 805.6898094233645, 811.736185739637, 813.800618848386, 824.5712229640553, 828.1180542721982, 7665.655045522964, 9241.930501160961, 9658.32391732586, 9769.560369783378, 9821.656242031495, 377115.0, 387000.0, 387880.0, 388731.0, 389902.0, 69513.65243173752, 74259.0, 75710.24289757032, 76074.0, 77467.61266193633, 910.7040211931148, 929.0523665860784, 934.6448349627099, 940.47333493244, 948.9572969216401, 14972.353041165681, 15124.39502419935, 15604.0, 15702.842971570139, 15835.208239588204, 37684.811575941945, 38055.80972095122, 38236.235275294894, 39011.659300442065, 39292.0, 51447.742761285954, 51650.74174629103, 52088.47911520836, 52614.210786837466, 53048.0, 6215.34738852414, 6869.828254293682, 7433.1823499416105, 7842.960785196037, 8029.518228906284, 8783.648654053766, 11281.266717663326, 11540.884591154318, 11688.298702077902, 11742.178047536932, 9914.702558923243, 9950.900490994998, 10009.249306302203, 10340.0, 10453.68638940833, 9463.0, 9489.857652135086, 9670.661526846527, 9906.75233119149, 10127.64553240633, 9367.344285900193, 9614.95192524033, 9637.18083962843, 10289.228307876789, 10361.585536578452, 7703.88444173349, 7759.495632783851, 7828.217178282126, 7834.707273299841, 8059.476134051268, 7581.0, 8949.373543852129, 9904.603815847573, 10031.498425078571, 10320.12278956297], "value": 9143.710036145181, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.8531376234853, 1315.7763180259356, 1365.975518361229, 1414.1939094716015, 1658.1626278729248, 6097.939020609792, 7008.929910700891, 7351.632418379087, 7360.30077142672, 7368.078990126234, 7045.89431158533, 7164.391026762732, 7195.6042417667, 7350.08123984502, 7366.116066072065, 2184.355615093551, 2241.204372447782, 2243.3606422169687, 2246.3485589179118, 2247.045005872506, 2167.967480487794, 2218.500837311608, 2223.899924503401, 2228.576570451609, 2228.888555572215, 2150.4838838678684, 2165.891705414731, 2180.5420861619077, 2182.432567532445, 2184.7487538932987, 2164.415607785897, 2173.152470536492, 2174.412908514708, 2174.6737989301573, 2174.8042676159143, 2147.0874878176714, 2186.6392045312505, 2188.8577242479187, 2189.6715492676226, 2190.69330293759, 7244.492885498017, 7382.298681625237, 7431.9256807431775, 7452.850942981164, 7475.364594009516, 4467.865964021084, 4669.533046695337, 4674.7428891410955, 4674.953250467486, 4677.672562920597, 2918.9270268243254, 2992.085065558045, 3048.786584939055, 3054.373853360056, 3060.785744997851, 904.674317245791, 907.1427501011547, 916.9954150229273, 918.5590916360118, 928.772450749564, 9998.550065247082, 10218.591256349737, 10233.181345492343, 10235.027672371112, 10235.641752538626, 4074.103697186614, 4096.651784598283, 4246.256905041605, 4252.234597772369, 4298.376735373354, 8726.912730872737, 8733.083026282276, 8803.031666516677, 8814.206721394978, 8824.470531768115, 4639.605633521121, 4648.2330415481065, 4650.51169627191, 4653.697509661861, 4655.906881862344, 3500.1949551603275, 4043.2924238258774, 4219.725717828332, 4239.915201695949, 4248.660107191417, 3653.598104208535, 3667.4132138857653, 3789.962100379016, 3798.1074447504816, 3806.410006449005, 1178.8938995490446, 1220.7619514194823, 1228.846394200725, 1237.1958227152243, 1240.6340129661771, 813.8006188483741, 832.5629044751432, 836.8451836410284, 865.6364326982682, 878.4597472554461, 5109.795608175631, 5179.533841954167, 5233.4243233244315, 5391.083515802323, 5471.644343117685, 387.45369029668035, 402.25984189092213, 403.7093292829158, 405.52148464811216, 405.7585736486786, 3529.7882127072457, 3636.254567813592, 3673.687736542424, 3689.2068205335445, 3783.981080094637, 9136.58885350161, 9375.10936461035, 9395.248380129573, 9449.858252126223, 9455.621775129055, 9333.859992100124, 9401.670941517013, 9415.717528474157, 9420.95289523548, 9424.528773561295, 6942.548734332252, 6994.790156295319, 7113.110861142461, 7124.323189297009, 7222.205557388683, 5307.4427185145005, 5311.203319501951, 5383.757730902197, 5414.29614150158, 5444.292242008513, 8344.207300306462, 8440.70457534008, 8445.746627601182, 8455.830883382421, 8540.231379175904, 8051.51690898548, 8230.21812927771, 8261.710840120568, 8740.694075707319, 8744.693935712474, 5597.272354593877, 6324.051392291193, 6373.77691780804, 6560.671966401565, 6578.309277525982, 6113.14415981754, 6190.659513726789, 6345.4923606112325, 6352.047192920914, 6358.713857876314, 6238.875222495434, 6475.805725828232, 6487.481001519962, 6498.707558159799, 6658.201015878126, 6260.843478913063, 6352.237731472253, 6417.422431981144, 6485.513586480938, 6540.444062254762, 6250.406211409909, 6290.119383286252, 6316.652584107918, 6323.652199129092, 6348.555601107878, 4473.150101480708, 4578.10726908263, 4600.861974140781, 4712.552307530779, 4909.754512274443, 4576.4508259009135, 4609.216433206296, 4613.815447382067, 4700.529947005272, 4712.175369310426], "value": 3977.069542128434, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.98699558519866, 289.74107502899903, 290.32499438804786, 299.13997257883585, 305.7783107247245, 4811.711297322163, 4812.590929770974, 4834.0, 4841.322214889914, 4851.58761505272, 4709.411323584552, 4741.8814529636775, 4801.615870730342, 4802.1836287831065, 4807.807687692497, 3603.7477376583715, 3700.7409481336317, 3701.2042410881654, 3774.848336448226, 3811.0, 3807.5430948286244, 3809.0, 3819.503464549605, 3833.5974722654137, 3842.7895213007814, 3761.1725420407465, 3773.6037666063594, 3778.1876896467256, 3783.6783873370796, 3783.924321513568, 3591.838367273479, 3624.0939765058733, 3711.740178187528, 3739.5886452490204, 3744.700423966076, 3308.106811160997, 3309.8179600121985, 3315.8673653053847, 3319.850606722703, 3328.417526932777, 4612.146752850734, 4654.2785868190485, 4662.510436404196, 4685.7657117144345, 4690.812367505296, 4154.563770804052, 4259.637930775888, 4262.211490874198, 4285.764282964436, 4290.442242508454, 4922.852314430573, 4951.43058548268, 4963.379577552806, 4965.9255111173, 4966.0, 3608.0, 3616.801075940822, 3618.3667858124986, 3625.9456108158133, 3632.529879681815, 4954.281629163787, 5234.973825130888, 5276.419593844674, 5284.180951952453, 5285.814996475105, 3555.6977656899453, 3584.946225806615, 3588.138846676831, 3588.982055089708, 3593.646161764049, 3629.1471504196493, 3633.3096711624707, 3642.834293026206, 3652.9817350913077, 3656.908577285536, 4206.621404073648, 4209.2633789086785, 4212.7682977435925, 4213.536510983789, 4219.9578004220175, 4742.454617718938, 5009.474005229398, 5028.622853286018, 5090.872728181825, 5092.541671249605, 1281.8974482041415, 1295.8509771376223, 1296.1898813241723, 1297.5523444411663, 1306.405585458614, 806.246159840551, 819.7253919936769, 825.8348330333957, 827.383599218586, 870.277669534285, 4369.388285640013, 4413.874462012231, 4424.358468022183, 4440.4005459263235, 4446.6220371268155, 5072.898542029138, 5090.720010399464, 5092.745362731848, 5095.566876815512, 5096.796128154906, 4314.158739045856, 4400.031992961543, 4438.755868427267, 4439.378487011821, 4448.843300741766, 2703.6485256916476, 2704.0400657766604, 2704.78361731061, 2705.809443844702, 2714.80996330255, 4818.132736107535, 4818.903621927542, 4821.156297647897, 4825.396825396825, 4836.443808961944, 5065.493450654905, 5096.566791822663, 5187.896242075213, 5197.636165468381, 5239.423663397023, 4800.1119792838435, 4820.529738429743, 4821.987382649612, 4848.5636292733825, 4852.902941941212, 5064.746762661778, 5073.0, 5075.796968121382, 5100.143919405145, 5101.183810590288, 4799.952000479951, 4975.278584605139, 5014.824481143142, 5019.553784144245, 5049.116404629249, 4833.419989601271, 4848.369711937426, 4857.975710121426, 4858.659893807399, 4869.245266983623, 3639.636036396339, 3649.3978493548266, 3649.470826730056, 3650.0874781304674, 3650.2516984018744, 4873.805047798191, 5097.617678674188, 5124.0, 5124.359455068116, 5135.820246291362, 4926.3349447824085, 4941.110600092018, 4943.332650092335, 4956.645593343133, 4961.05739909416, 4944.826931057396, 4951.653384263067, 4953.603711702983, 4968.975155124202, 4969.552740253394, 4618.214903466486, 4836.540528649773, 4868.440129385024, 4871.098846713369, 4871.634627402888, 4782.976085119552, 4879.414470263591, 4945.208766597327, 4947.851564453073, 5021.799128034838, 4926.556609905126, 4944.4066711993355, 4959.0, 4962.900741985212, 4967.950320496893], "value": 3760.7712568185725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.5110668470262, 626.3048016701462, 640.6636515829186, 693.3863530775262, 705.7812078255741, 12685.936570317148, 13136.0, 13638.454461821515, 13832.446702131916, 13852.58442246733, 13327.933360333185, 13639.93180034101, 13642.590722278323, 13644.72710545791, 13669.11150775199, 603.3182503770732, 749.2208103572292, 769.430621340207, 771.7684694591628, 772.0696560644438, 746.8655641984441, 762.6949220311864, 762.9694812207533, 773.7640019793961, 774.8334108166744, 806.681360862459, 807.7617102954642, 808.030363563723, 808.6926967752246, 808.7290757596212, 631.6462780842743, 805.279275048831, 805.4482679364595, 805.875089361147, 807.0638059850575, 566.2949627713523, 575.8301301116181, 578.9942100578983, 584.1325631437312, 584.9181114643953, 13317.400716967759, 13370.064095513319, 13413.530526431528, 13436.328183590782, 13438.328083595781, 12079.275243485332, 12293.446794894251, 12436.502539898393, 12444.502219911192, 12533.310667913353, 9058.864117038249, 9149.634014639407, 9169.449833010041, 9669.613215471372, 12211.389430528527, 4151.564085771011, 4160.646345060673, 4182.0, 4190.413342132104, 4257.276263035261, 61073.69463152656, 61779.69110154465, 61908.38091619116, 61973.380266197215, 61988.99999999955, 9033.322500812465, 9257.953710231406, 9642.276829237835, 9967.850482242773, 10037.297389182688, 16882.493525194262, 17020.829791701923, 17049.31802727902, 17102.48692539226, 17113.144342782813, 6888.862222755617, 6924.0, 6926.549774264657, 7056.400205982446, 7133.5719856808755, 3530.152763336832, 3626.274745050948, 3729.869454569077, 3810.6760925321105, 3818.312703713358, 2912.6504819421807, 3026.7881248312847, 3030.3181784098842, 3047.360054388603, 3049.8780048798244, 496.1466278001831, 504.70979186966906, 508.3569284854662, 510.3314657798296, 517.0279873837162, 446.19617758607484, 499.1140725212704, 591.5651995783096, 596.1653684841257, 603.1736520966305, 7192.280771922766, 7621.0, 7625.0, 7647.158812530728, 8000.479968802009, 577.6418620455345, 592.8191901470007, 597.7130977131002, 605.8273392083236, 605.9818205453844, 3517.4150440051167, 3666.74332796707, 3667.3582123128344, 3683.7605555638797, 3762.830672619739, 104476.0, 105404.0, 106701.0, 109087.90912090936, 109119.0, 81973.0, 85580.0, 91858.54070729604, 92366.53816730874, 94886.52556737172, 50129.0, 59190.70404647949, 71994.0, 72970.27029729635, 75859.0, 7596.202398748273, 8087.3125784308995, 8181.427300088937, 8190.385721070825, 8243.175682431709, 44254.0, 44325.33511997258, 44754.77622611866, 45420.318695218935, 45852.77073614744, 51052.489475104776, 61895.38104618896, 62174.37825621867, 62326.68836655788, 64878.02682959854, 9267.44395336282, 9411.435313880915, 9615.375000624937, 9703.6118555257, 10106.090451859369, 11518.596849110241, 11640.610284422772, 11718.0, 11817.172797904408, 12057.939710301393, 11083.612073577386, 11181.105511559219, 11346.262492938264, 11722.296662200295, 11767.470463829319, 10896.12830973536, 11433.371164586028, 11759.647210583697, 12107.394630268627, 12132.575359862716, 10719.0, 10857.837132443177, 11010.889891100986, 11234.775304494027, 11245.493952772309, 9011.414258073204, 9101.135392137736, 9220.0, 9324.347295689236, 9414.19979301767, 9063.68277110298, 9105.954470227607, 9115.817683646157, 9620.801949933093, 9710.660126895526], "value": 6421.217169771788, "unit": "score"}], "name": "dromaeo_css", "value": 6413.85036436732, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 113.0, 115.0, 115.0, 114.0, 112.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 127.0, 123.0, 182.0, 122.0, 123.0, 151.0, 121.0, 160.0, 126.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 159.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 114.0, 76.0, 77.0, 77.0, 75.0, 101.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 111.0, 85.0, 86.0, 84.0, 117.0, 85.0, 86.0, 133.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 67.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 89.0, 82.0, 79.0, 79.0, 79.0, 89.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 130.0, 139.0, 141.0, 130.0, 130.0, 143.0, 177.0, 140.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 164.0, 166.0, 164.0, 162.0, 167.0, 171.0, 168.0, 168.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 68.0, 68.0, 68.0, 66.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1530.9, "alertThreshold": 2.0}]} 14:08:21 INFO - Return code: 0 14:08:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:08:21 INFO - # TBPL SUCCESS # 14:08:21 INFO - Running post-action listener: _resource_record_post_action 14:08:21 INFO - [mozharness: 2016-08-01 21:08:21.863652Z] Finished run-tests step (success) 14:08:21 INFO - Running post-run listener: _resource_record_post_run 14:08:21 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533086208; Read time: 20; Write time: 506232 14:08:21 INFO - TinderboxPrint: CPU usage
13.0% 14:08:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:08:21 INFO - TinderboxPrint: I/O write bytes / time
533,086,208 / 506,232 14:08:21 INFO - TinderboxPrint: CPU idle
8,325.4 (87.0%) 14:08:21 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 14:08:21 INFO - TinderboxPrint: Swap in / out
0 / 0 14:08:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248782848; Read time: 0; Write time: 301740 14:08:21 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 284303360; Read time: 0; Write time: 204492 14:08:22 INFO - Running post-run listener: _upload_blobber_files 14:08:22 INFO - Blob upload gear active. 14:08:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:08:22 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 14:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:08:22 INFO - (blobuploader) - INFO - Open directory for files ... 14:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:08:23 INFO - (blobuploader) - INFO - Done attempting. 14:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:08:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:08:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:08:27 INFO - (blobuploader) - INFO - Done attempting. 14:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:08:28 INFO - (blobuploader) - INFO - Done attempting. 14:08:28 INFO - (blobuploader) - INFO - Iteration through files over. 14:08:28 INFO - Return code: 0 14:08:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:08:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:08:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c53f9f6c0eeb4b852fa57a0cd79032f86e2e3765627e8bbcc14a44357492904d819af492d54edd28230bdae0cbaa4140c36cae17f4854e83154589eca717b0a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/704d2f612f5062f4ca2fbcb04ea7b21bee9638042b12144cdeaa952b5e2fad1eb5c4db8a2eccad8ac0966af218d32c2aca700689741088a125a1c2f249641346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/803de0ff97215e0e5e2fd9ec5780820e546b3ec2b9a6e97ab8827be931895037e7be628fe4a7b60f76f80032f72608ee243b3b87f6d80dcb3c4ba473abcdf028"} 14:08:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:08:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:08:28 INFO - Contents: 14:08:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c53f9f6c0eeb4b852fa57a0cd79032f86e2e3765627e8bbcc14a44357492904d819af492d54edd28230bdae0cbaa4140c36cae17f4854e83154589eca717b0a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/704d2f612f5062f4ca2fbcb04ea7b21bee9638042b12144cdeaa952b5e2fad1eb5c4db8a2eccad8ac0966af218d32c2aca700689741088a125a1c2f249641346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/803de0ff97215e0e5e2fd9ec5780820e546b3ec2b9a6e97ab8827be931895037e7be628fe4a7b60f76f80032f72608ee243b3b87f6d80dcb3c4ba473abcdf028"} 14:08:28 INFO - Running post-run listener: copy_logs_to_upload_dir 14:08:28 INFO - Copying logs to upload dir... 14:08:28 INFO - mkdir: /builds/slave/test/build/upload/logs 14:08:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.891702 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-01 14:08:25.728894) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 14:08:25.732339) ========= 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=826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c53f9f6c0eeb4b852fa57a0cd79032f86e2e3765627e8bbcc14a44357492904d819af492d54edd28230bdae0cbaa4140c36cae17f4854e83154589eca717b0a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/704d2f612f5062f4ca2fbcb04ea7b21bee9638042b12144cdeaa952b5e2fad1eb5c4db8a2eccad8ac0966af218d32c2aca700689741088a125a1c2f249641346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/803de0ff97215e0e5e2fd9ec5780820e546b3ec2b9a6e97ab8827be931895037e7be628fe4a7b60f76f80032f72608ee243b3b87f6d80dcb3c4ba473abcdf028"} build_url:https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/UsrjDL3-R9CZfj1Uehy5pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c53f9f6c0eeb4b852fa57a0cd79032f86e2e3765627e8bbcc14a44357492904d819af492d54edd28230bdae0cbaa4140c36cae17f4854e83154589eca717b0a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/704d2f612f5062f4ca2fbcb04ea7b21bee9638042b12144cdeaa952b5e2fad1eb5c4db8a2eccad8ac0966af218d32c2aca700689741088a125a1c2f249641346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/803de0ff97215e0e5e2fd9ec5780820e546b3ec2b9a6e97ab8827be931895037e7be628fe4a7b60f76f80032f72608ee243b3b87f6d80dcb3c4ba473abcdf028"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 14:08:25.759765) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 14:08:25.760093) ========= 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=826874ccc97bd7bf541b4875000001d5-1470084469.76771-1117327441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 14:08:25.845696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 14:08:25.846022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 14:08:25.846312) ========= ========= Total master_lag: 0.16 =========