builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1469708447.39 results: success (0) buildid: 20160728023018 builduid: 4ef3f5750efd4d25aa7e052f93932b65 revision: e82080019746478198c4009ba0c5c358be3f0359 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.394870) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.395380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.395707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.410525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.410877) ========= 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=0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 05:20:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.7M=0s 2016-07-28 05:20:48 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139764 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.564996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.565403) ========= 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=0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015638 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:47.615298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 05:20:47.615656) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e82080019746478198c4009ba0c5c358be3f0359 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e82080019746478198c4009ba0c5c358be3f0359 --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=0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 05:20:48,235 truncating revision to first 12 chars 2016-07-28 05:20:48,235 Setting DEBUG logging. 2016-07-28 05:20:48,235 attempt 1/10 2016-07-28 05:20:48,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e82080019746?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 05:20:49,001 unpacking tar archive at: fx-team-e82080019746/testing/mozharness/ program finished with exit code 0 elapsedTime=1.141886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 05:20:48.772479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:48.772959) ========= script_repo_revision: e82080019746478198c4009ba0c5c358be3f0359 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:48.773580) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:48.773965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 05:20:48.784195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-28 05:20:48.784575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:49 INFO - MultiFileLogger online at 20160728 05:20:49 in /builds/slave/test 05:20:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:20:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:49 INFO - {'append_to_log': False, 05:20:49 INFO - 'base_work_dir': '/builds/slave/test', 05:20:49 INFO - 'blob_upload_branch': 'Fx-Team', 05:20:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:49 INFO - 'branch': 'Fx-Team', 05:20:49 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:49 INFO - 'config_files': ('talos/linux_config.py',), 05:20:49 INFO - 'default_actions': ('clobber', 05:20:49 INFO - 'read-buildbot-config', 05:20:49 INFO - 'download-and-extract', 05:20:49 INFO - 'populate-webroot', 05:20:49 INFO - 'create-virtualenv', 05:20:49 INFO - 'install', 05:20:49 INFO - 'run-tests'), 05:20:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:49 INFO - 'download_minidump_stackwalk': True, 05:20:49 INFO - 'download_symbols': 'ondemand', 05:20:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:49 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:49 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:49 INFO - 'installer_path': 'installer.exe', 05:20:49 INFO - 'log_level': 'info', 05:20:49 INFO - 'log_name': 'talos', 05:20:49 INFO - 'log_to_console': True, 05:20:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:49 INFO - 'opt_config_files': (), 05:20:49 INFO - 'pip_index': False, 05:20:49 INFO - 'sps_profile': False, 05:20:49 INFO - 'sps_profile_interval': 0, 05:20:49 INFO - 'suite': 'dromaeojs', 05:20:49 INFO - 'system_bits': '32', 05:20:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:49 INFO - 'title': 'talos-linux64-ix-017', 05:20:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:49 INFO - 'use_talos_json': True, 05:20:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:49 INFO - 'work_dir': 'build'} 05:20:49 INFO - [mozharness: 2016-07-28 12:20:49.497732Z] Running clobber step. 05:20:49 INFO - Running pre-action listener: _resource_record_pre_action 05:20:49 INFO - Running main action method: clobber 05:20:49 INFO - rmtree: /builds/slave/test/build 05:20:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:49 INFO - Running post-action listener: _resource_record_post_action 05:20:49 INFO - [mozharness: 2016-07-28 12:20:49.973386Z] Finished clobber step (success) 05:20:49 INFO - [mozharness: 2016-07-28 12:20:49.973487Z] Running read-buildbot-config step. 05:20:49 INFO - Running pre-action listener: _resource_record_pre_action 05:20:49 INFO - Running main action method: read_buildbot_config 05:20:49 INFO - Using buildbot properties: 05:20:49 INFO - { 05:20:49 INFO - "project": "", 05:20:49 INFO - "product": "firefox", 05:20:49 INFO - "script_repo_revision": "production", 05:20:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:20:49 INFO - "repository": "", 05:20:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:20:49 INFO - "buildid": "20160728023018", 05:20:49 INFO - "pgo_build": "True", 05:20:49 INFO - "basedir": "/builds/slave/test", 05:20:49 INFO - "buildnumber": 1377, 05:20:49 INFO - "slavename": "talos-linux64-ix-017", 05:20:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:20:49 INFO - "platform": "ubuntu64_hw", 05:20:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:20:49 INFO - "branch": "fx-team", 05:20:49 INFO - "repo_path": "integration/fx-team", 05:20:49 INFO - "revision": "e82080019746478198c4009ba0c5c358be3f0359", 05:20:49 INFO - "stage_platform": "linux64-pgo", 05:20:49 INFO - "builduid": "4ef3f5750efd4d25aa7e052f93932b65", 05:20:49 INFO - "slavebuilddir": "test" 05:20:49 INFO - } 05:20:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:20:49 INFO - Running post-action listener: _resource_record_post_action 05:20:49 INFO - [mozharness: 2016-07-28 12:20:49.975919Z] Finished read-buildbot-config step (success) 05:20:49 INFO - [mozharness: 2016-07-28 12:20:49.976007Z] Running download-and-extract step. 05:20:49 INFO - Running pre-action listener: _resource_record_pre_action 05:20:49 INFO - Running main action method: download_and_extract 05:20:49 INFO - mkdir: /builds/slave/test/build/tests 05:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:49 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:20:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:50 INFO - Downloaded 1361 bytes. 05:20:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:50 INFO - Using the following test package requirements: 05:20:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'jsshell-linux-x86_64.zip'], 05:20:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:50 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:52 INFO - Downloaded 24318744 bytes. 05:20:52 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'] 05:20:52 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 05:20:53 INFO - Return code: 0 05:20:53 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 05:20: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')]} 05:20:53 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:54 INFO - Downloaded 24318744 bytes. 05:20: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'] 05:20: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 05:20:55 INFO - Return code: 0 05:20: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')]} 05:20:55 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:56 INFO - Downloaded 14413725 bytes. 05:20:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:20:56 INFO - Return code: 0 05:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:56 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:20:58 INFO - Downloaded 60989495 bytes. 05:20:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:58 INFO - mkdir: /builds/slave/test/properties 05:20:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:58 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:58 INFO - Contents: 05:20:58 INFO - build_url:https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:58 INFO - Running post-action listener: _resource_record_post_action 05:20:58 INFO - Running post-action listener: set_extra_try_arguments 05:20:58 INFO - [mozharness: 2016-07-28 12:20:58.865720Z] Finished download-and-extract step (success) 05:20:58 INFO - [mozharness: 2016-07-28 12:20:58.865952Z] Running populate-webroot step. 05:20:58 INFO - Running pre-action listener: _resource_record_pre_action 05:20:58 INFO - Running main action method: populate_webroot 05:20:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:58 INFO - '--tppagecycles', 05:20:58 INFO - '7'], 05:20:58 INFO - 'tests': ['tsvgm']}}, 05:20:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['damp', 'tps']}, 05:20:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'tests': ['damp', 'tps']}, 05:20:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['dromaeo_dom']}, 05:20:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['basic_compositor_video']}, 05:20:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:20:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['a11yr', 05:20:58 INFO - 'ts_paint', 05:20:58 INFO - 'tpaint', 05:20:58 INFO - 'sessionrestore', 05:20:58 INFO - 'sessionrestore_no_auto_restore', 05:20:58 INFO - 'tabpaint']}, 05:20:58 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:58 INFO - 'ts_paint', 05:20:58 INFO - 'tpaint', 05:20:58 INFO - 'sessionrestore', 05:20:58 INFO - 'sessionrestore_no_auto_restore', 05:20:58 INFO - 'tabpaint']}, 05:20:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:58 INFO - 'ts_paint', 05:20:58 INFO - 'tpaint', 05:20:58 INFO - 'sessionrestore', 05:20:58 INFO - 'sessionrestore_no_auto_restore', 05:20:58 INFO - 'tabpaint']}, 05:20:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:58 INFO - 'ts_paint', 05:20:58 INFO - 'tpaint', 05:20:58 INFO - 'sessionrestore', 05:20:58 INFO - 'sessionrestore_no_auto_restore', 05:20:58 INFO - 'tabpaint']}, 05:20:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['a11yr', 05:20:58 INFO - 'ts_paint', 05:20:58 INFO - 'tpaint', 05:20:58 INFO - 'sessionrestore', 05:20:58 INFO - 'sessionrestore_no_auto_restore', 05:20:58 INFO - 'tabpaint']}, 05:20:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['a11yr', 05:20:58 INFO - 'ts_paint', 05:20:58 INFO - 'tpaint', 05:20:58 INFO - 'sessionrestore', 05:20:58 INFO - 'sessionrestore_no_auto_restore', 05:20:58 INFO - 'tabpaint']}, 05:20:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['tsvgx', 05:20:58 INFO - 'tsvgr_opacity', 05:20:58 INFO - 'tart', 05:20:58 INFO - 'tscrollx', 05:20:58 INFO - 'cart']}, 05:20:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:58 INFO - 'tsvgr_opacity', 05:20:58 INFO - 'tart', 05:20:58 INFO - 'tscrollx', 05:20:58 INFO - 'cart']}, 05:20:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'talos_options': ['--disable-e10s'], 05:20:58 INFO - 'tests': ['tp5o']}, 05:20:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'tests': ['tp5o']}, 05:20:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'talos_options': ['--disable-e10s', 05:20:58 INFO - '--xperf_path', 05:20:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:58 INFO - 'tests': ['tp5n']}, 05:20:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:58 INFO - 'talos_options': ['--xperf_path', 05:20:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:58 INFO - 'tests': ['tp5n']}}, 05:20:58 INFO - 'talos.zip': {'path': '', 05:20:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:58 INFO - Running post-action listener: _resource_record_post_action 05:20:58 INFO - [mozharness: 2016-07-28 12:20:58.881525Z] Finished populate-webroot step (success) 05:20:58 INFO - [mozharness: 2016-07-28 12:20:58.881614Z] Running create-virtualenv step. 05:20:58 INFO - Running pre-action listener: _resource_record_pre_action 05:20:58 INFO - Running main action method: create_virtualenv 05:20:58 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:20:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:58 INFO - Using real prefix '/usr' 05:20:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:01 INFO - Installing pip.................done. 05:21:01 INFO - Return code: 0 05:21:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:21:01 INFO - Using env: {'DISPLAY': ':0', 05:21:01 INFO - 'HOME': '/home/cltbld', 05:21:01 INFO - 'LANG': 'en_US.UTF-8', 05:21:01 INFO - 'LANGUAGE': 'en_US:en', 05:21:01 INFO - 'LOGNAME': 'cltbld', 05:21:01 INFO - 'MAIL': '/var/mail/cltbld', 05:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:01 INFO - 'MOZ_NO_REMOTE': '1', 05:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:01 INFO - 'NO_EM_RESTART': '1', 05:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:01 INFO - 'PWD': '/builds/slave/test', 05:21:01 INFO - 'SHELL': '/bin/bash', 05:21:01 INFO - 'SHLVL': '1', 05:21:01 INFO - 'TERM': 'linux', 05:21:01 INFO - 'TMOUT': '86400', 05:21:01 INFO - 'USER': 'cltbld', 05:21:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:01 INFO - '_': '/tools/buildbot/bin/python'} 05:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:21:01 INFO - Cleaning up... 05:21:01 INFO - Return code: 0 05:21:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:21:01 INFO - Using env: {'DISPLAY': ':0', 05:21:01 INFO - 'HOME': '/home/cltbld', 05:21:01 INFO - 'LANG': 'en_US.UTF-8', 05:21:01 INFO - 'LANGUAGE': 'en_US:en', 05:21:01 INFO - 'LOGNAME': 'cltbld', 05:21:01 INFO - 'MAIL': '/var/mail/cltbld', 05:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:01 INFO - 'MOZ_NO_REMOTE': '1', 05:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:01 INFO - 'NO_EM_RESTART': '1', 05:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:01 INFO - 'PWD': '/builds/slave/test', 05:21:01 INFO - 'SHELL': '/bin/bash', 05:21:01 INFO - 'SHLVL': '1', 05:21:01 INFO - 'TERM': 'linux', 05:21:01 INFO - 'TMOUT': '86400', 05:21:01 INFO - 'USER': 'cltbld', 05:21:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:01 INFO - '_': '/tools/buildbot/bin/python'} 05:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:01 INFO - Downloading/unpacking psutil>=3.1.1 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:04 INFO - Installing collected packages: psutil 05:21:04 INFO - Running setup.py install for psutil 05:21:04 INFO - building 'psutil._psutil_linux' extension 05:21:04 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 05:21:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:21:04 INFO - building 'psutil._psutil_posix' extension 05:21:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:21:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:21:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:04 INFO - Successfully installed psutil 05:21:04 INFO - Cleaning up... 05:21:04 INFO - Return code: 0 05:21:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:21:04 INFO - Using env: {'DISPLAY': ':0', 05:21:04 INFO - 'HOME': '/home/cltbld', 05:21:04 INFO - 'LANG': 'en_US.UTF-8', 05:21:04 INFO - 'LANGUAGE': 'en_US:en', 05:21:04 INFO - 'LOGNAME': 'cltbld', 05:21:04 INFO - 'MAIL': '/var/mail/cltbld', 05:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:04 INFO - 'MOZ_NO_REMOTE': '1', 05:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:04 INFO - 'NO_EM_RESTART': '1', 05:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:04 INFO - 'PWD': '/builds/slave/test', 05:21:04 INFO - 'SHELL': '/bin/bash', 05:21:04 INFO - 'SHLVL': '1', 05:21:04 INFO - 'TERM': 'linux', 05:21:04 INFO - 'TMOUT': '86400', 05:21:04 INFO - 'USER': 'cltbld', 05:21:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:04 INFO - '_': '/tools/buildbot/bin/python'} 05:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:21:06 INFO - Installing collected packages: mozsystemmonitor 05:21:06 INFO - Running setup.py install for mozsystemmonitor 05:21:06 INFO - Successfully installed mozsystemmonitor 05:21:06 INFO - Cleaning up... 05:21:06 INFO - Return code: 0 05:21:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:21:06 INFO - Using env: {'DISPLAY': ':0', 05:21:06 INFO - 'HOME': '/home/cltbld', 05:21:06 INFO - 'LANG': 'en_US.UTF-8', 05:21:06 INFO - 'LANGUAGE': 'en_US:en', 05:21:06 INFO - 'LOGNAME': 'cltbld', 05:21:06 INFO - 'MAIL': '/var/mail/cltbld', 05:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:06 INFO - 'MOZ_NO_REMOTE': '1', 05:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:06 INFO - 'NO_EM_RESTART': '1', 05:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:06 INFO - 'PWD': '/builds/slave/test', 05:21:06 INFO - 'SHELL': '/bin/bash', 05:21:06 INFO - 'SHLVL': '1', 05:21:06 INFO - 'TERM': 'linux', 05:21:06 INFO - 'TMOUT': '86400', 05:21:06 INFO - 'USER': 'cltbld', 05:21:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:06 INFO - '_': '/tools/buildbot/bin/python'} 05:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:21:07 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 05:21:07 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 05:21:07 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 05:21:07 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 05:21:07 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 05:21:07 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 05:21:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:09 INFO - warning: no files found matching '*.txt' 05:21:09 INFO - no previously-included directories found matching 'build' 05:21:09 INFO - no previously-included directories found matching 'dist' 05:21:09 INFO - no previously-included directories found matching '.git*' 05:21:09 INFO - Installing collected packages: jsonschema, functools32 05:21:09 INFO - Running setup.py install for functools32 05:21:09 INFO - warning: no files found matching '*.txt' 05:21:09 INFO - no previously-included directories found matching 'build' 05:21:09 INFO - no previously-included directories found matching 'dist' 05:21:09 INFO - no previously-included directories found matching '.git*' 05:21:09 INFO - Successfully installed jsonschema functools32 05:21:09 INFO - Cleaning up... 05:21:09 INFO - Return code: 0 05:21:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:21:09 INFO - Using env: {'DISPLAY': ':0', 05:21:09 INFO - 'HOME': '/home/cltbld', 05:21:09 INFO - 'LANG': 'en_US.UTF-8', 05:21:09 INFO - 'LANGUAGE': 'en_US:en', 05:21:09 INFO - 'LOGNAME': 'cltbld', 05:21:09 INFO - 'MAIL': '/var/mail/cltbld', 05:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:09 INFO - 'MOZ_NO_REMOTE': '1', 05:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:09 INFO - 'NO_EM_RESTART': '1', 05:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:09 INFO - 'PWD': '/builds/slave/test', 05:21:09 INFO - 'SHELL': '/bin/bash', 05:21:09 INFO - 'SHLVL': '1', 05:21:09 INFO - 'TERM': 'linux', 05:21:09 INFO - 'TMOUT': '86400', 05:21:09 INFO - 'USER': 'cltbld', 05:21:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:09 INFO - '_': '/tools/buildbot/bin/python'} 05:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:21:09 INFO - Cleaning up... 05:21:09 INFO - Return code: 0 05:21:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:09 INFO - Using env: {'DISPLAY': ':0', 05:21:09 INFO - 'HOME': '/home/cltbld', 05:21:09 INFO - 'LANG': 'en_US.UTF-8', 05:21:09 INFO - 'LANGUAGE': 'en_US:en', 05:21:09 INFO - 'LOGNAME': 'cltbld', 05:21:09 INFO - 'MAIL': '/var/mail/cltbld', 05:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:09 INFO - 'MOZ_NO_REMOTE': '1', 05:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:09 INFO - 'NO_EM_RESTART': '1', 05:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:09 INFO - 'PWD': '/builds/slave/test', 05:21:09 INFO - 'SHELL': '/bin/bash', 05:21:09 INFO - 'SHLVL': '1', 05:21:09 INFO - 'TERM': 'linux', 05:21:09 INFO - 'TMOUT': '86400', 05:21:09 INFO - 'USER': 'cltbld', 05:21:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:09 INFO - '_': '/tools/buildbot/bin/python'} 05:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:12 INFO - Downloading docopt-0.6.1.tar.gz 05:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:12 INFO - Running setup.py install for blobuploader 05:21:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:12 INFO - Running setup.py install for requests 05:21:13 INFO - Running setup.py install for docopt 05:21:13 INFO - Successfully installed blobuploader requests docopt 05:21:13 INFO - Cleaning up... 05:21:13 INFO - Return code: 0 05:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:13 INFO - Using env: {'DISPLAY': ':0', 05:21:13 INFO - 'HOME': '/home/cltbld', 05:21:13 INFO - 'LANG': 'en_US.UTF-8', 05:21:13 INFO - 'LANGUAGE': 'en_US:en', 05:21:13 INFO - 'LOGNAME': 'cltbld', 05:21:13 INFO - 'MAIL': '/var/mail/cltbld', 05:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:13 INFO - 'MOZ_NO_REMOTE': '1', 05:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:13 INFO - 'NO_EM_RESTART': '1', 05:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:13 INFO - 'PWD': '/builds/slave/test', 05:21:13 INFO - 'SHELL': '/bin/bash', 05:21:13 INFO - 'SHLVL': '1', 05:21:13 INFO - 'TERM': 'linux', 05:21:13 INFO - 'TMOUT': '86400', 05:21:13 INFO - 'USER': 'cltbld', 05:21:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:13 INFO - '_': '/tools/buildbot/bin/python'} 05:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:13 INFO - Running setup.py (path:/tmp/pip-uXNwmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:13 INFO - Running setup.py (path:/tmp/pip-VWux1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:13 INFO - Running setup.py (path:/tmp/pip-Zn9hjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:13 INFO - Running setup.py (path:/tmp/pip-w31xrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:13 INFO - Running setup.py (path:/tmp/pip-7wZyjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:13 INFO - Running setup.py (path:/tmp/pip-cAaveV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:13 INFO - Running setup.py (path:/tmp/pip-9RA0xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:13 INFO - Running setup.py (path:/tmp/pip-swZSdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:13 INFO - Running setup.py (path:/tmp/pip-3ZB1sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:14 INFO - Running setup.py (path:/tmp/pip-jhCTVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:14 INFO - Running setup.py (path:/tmp/pip-z8MuDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:14 INFO - Running setup.py (path:/tmp/pip-cGui_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:14 INFO - Running setup.py (path:/tmp/pip-T3ecMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:14 INFO - Running setup.py (path:/tmp/pip-dyxJ9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:14 INFO - Running setup.py (path:/tmp/pip-u0lRWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:14 INFO - Running setup.py (path:/tmp/pip-EZ9aIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:14 INFO - Running setup.py (path:/tmp/pip-PKXs9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:14 INFO - Running setup.py install for manifestparser 05:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:14 INFO - Running setup.py install for mozcrash 05:21:14 INFO - Running setup.py install for mozdebug 05:21:14 INFO - Running setup.py install for mozdevice 05:21:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozfile 05:21:15 INFO - Running setup.py install for mozhttpd 05:21:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozinfo 05:21:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozInstall 05:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozleak 05:21:15 INFO - Running setup.py install for mozlog 05:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for moznetwork 05:21:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozprocess 05:21:15 INFO - Running setup.py install for mozprofile 05:21:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:15 INFO - Running setup.py install for mozrunner 05:21:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:16 INFO - Running setup.py install for mozscreenshot 05:21:16 INFO - Running setup.py install for moztest 05:21:16 INFO - Running setup.py install for mozversion 05:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:16 INFO - Cleaning up... 05:21:16 INFO - Return code: 0 05:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:16 INFO - Using env: {'DISPLAY': ':0', 05:21:16 INFO - 'HOME': '/home/cltbld', 05:21:16 INFO - 'LANG': 'en_US.UTF-8', 05:21:16 INFO - 'LANGUAGE': 'en_US:en', 05:21:16 INFO - 'LOGNAME': 'cltbld', 05:21:16 INFO - 'MAIL': '/var/mail/cltbld', 05:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:16 INFO - 'MOZ_NO_REMOTE': '1', 05:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:16 INFO - 'NO_EM_RESTART': '1', 05:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:16 INFO - 'PWD': '/builds/slave/test', 05:21:16 INFO - 'SHELL': '/bin/bash', 05:21:16 INFO - 'SHLVL': '1', 05:21:16 INFO - 'TERM': 'linux', 05:21:16 INFO - 'TMOUT': '86400', 05:21:16 INFO - 'USER': 'cltbld', 05:21:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:16 INFO - '_': '/tools/buildbot/bin/python'} 05:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:16 INFO - Running setup.py (path:/tmp/pip-D4HJsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:16 INFO - Running setup.py (path:/tmp/pip-iutHcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:16 INFO - Running setup.py (path:/tmp/pip-vPJIi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:16 INFO - Running setup.py (path:/tmp/pip-ExBGG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:16 INFO - Running setup.py (path:/tmp/pip-aR_JdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:17 INFO - Running setup.py (path:/tmp/pip-Zfnsi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:17 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)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:17 INFO - Running setup.py (path:/tmp/pip-WgNMU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:17 INFO - Running setup.py (path:/tmp/pip-OoLdka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:17 INFO - Running setup.py (path:/tmp/pip-uOc3om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:17 INFO - Running setup.py (path:/tmp/pip-x3kAKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:17 INFO - Running setup.py (path:/tmp/pip-Kct67_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:17 INFO - Running setup.py (path:/tmp/pip-JrwsLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:17 INFO - Running setup.py (path:/tmp/pip-p3LA0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:17 INFO - Running setup.py (path:/tmp/pip-ZArxVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:17 INFO - Running setup.py (path:/tmp/pip-v8TFbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:17 INFO - Running setup.py (path:/tmp/pip-MGQVev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:17 INFO - Running setup.py (path:/tmp/pip-SzG6_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - Downloading blessings-1.6.tar.gz 05:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:19 INFO - Installing collected packages: blessings 05:21:19 INFO - Running setup.py install for blessings 05:21:19 INFO - Successfully installed blessings 05:21:19 INFO - Cleaning up... 05:21:20 INFO - Return code: 0 05:21:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:20 INFO - Reading from file tmpfile_stdout 05:21:20 INFO - Current package versions: 05:21:20 INFO - argparse == 1.2.1 05:21:20 INFO - blessings == 1.6 05:21:20 INFO - blobuploader == 1.2.4 05:21:20 INFO - docopt == 0.6.1 05:21:20 INFO - functools32 == 3.2.3-2 05:21:20 INFO - jsonschema == 2.5.1 05:21:20 INFO - manifestparser == 1.1 05:21:20 INFO - mozInstall == 1.12 05:21:20 INFO - mozcrash == 0.17 05:21:20 INFO - mozdebug == 0.1 05:21:20 INFO - mozdevice == 0.48 05:21:20 INFO - mozfile == 1.2 05:21:20 INFO - mozhttpd == 0.7 05:21:20 INFO - mozinfo == 0.9 05:21:20 INFO - mozleak == 0.1 05:21:20 INFO - mozlog == 3.3 05:21:20 INFO - moznetwork == 0.27 05:21:20 INFO - mozprocess == 0.23 05:21:20 INFO - mozprofile == 0.28 05:21:20 INFO - mozrunner == 6.12 05:21:20 INFO - mozscreenshot == 0.1 05:21:20 INFO - mozsystemmonitor == 0.3 05:21:20 INFO - moztest == 0.7 05:21:20 INFO - mozversion == 1.4 05:21:20 INFO - psutil == 3.1.1 05:21:20 INFO - requests == 1.2.3 05:21:20 INFO - wsgiref == 0.1.2 05:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:20 INFO - Using env: {'DISPLAY': ':0', 05:21:20 INFO - 'HOME': '/home/cltbld', 05:21:20 INFO - 'LANG': 'en_US.UTF-8', 05:21:20 INFO - 'LANGUAGE': 'en_US:en', 05:21:20 INFO - 'LOGNAME': 'cltbld', 05:21:20 INFO - 'MAIL': '/var/mail/cltbld', 05:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:20 INFO - 'MOZ_NO_REMOTE': '1', 05:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:20 INFO - 'NO_EM_RESTART': '1', 05:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:20 INFO - 'PWD': '/builds/slave/test', 05:21:20 INFO - 'SHELL': '/bin/bash', 05:21:20 INFO - 'SHLVL': '1', 05:21:20 INFO - 'TERM': 'linux', 05:21:20 INFO - 'TMOUT': '86400', 05:21:20 INFO - 'USER': 'cltbld', 05:21:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:20 INFO - '_': '/tools/buildbot/bin/python'} 05:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:20 INFO - Cleaning up... 05:21:20 INFO - Return code: 0 05:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, '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': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', '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 05:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:21:20 INFO - Using env: {'DISPLAY': ':0', 05:21:20 INFO - 'HOME': '/home/cltbld', 05:21:20 INFO - 'LANG': 'en_US.UTF-8', 05:21:20 INFO - 'LANGUAGE': 'en_US:en', 05:21:20 INFO - 'LOGNAME': 'cltbld', 05:21:20 INFO - 'MAIL': '/var/mail/cltbld', 05:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:20 INFO - 'MOZ_NO_REMOTE': '1', 05:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:20 INFO - 'NO_EM_RESTART': '1', 05:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:20 INFO - 'PWD': '/builds/slave/test', 05:21:20 INFO - 'SHELL': '/bin/bash', 05:21:20 INFO - 'SHLVL': '1', 05:21:20 INFO - 'TERM': 'linux', 05:21:20 INFO - 'TMOUT': '86400', 05:21:20 INFO - 'USER': 'cltbld', 05:21:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:20 INFO - '_': '/tools/buildbot/bin/python'} 05:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:21:20 INFO - Cleaning up... 05:21:20 INFO - Return code: 0 05:21:20 INFO - Running post-action listener: _resource_record_post_action 05:21:20 INFO - Running post-action listener: _start_resource_monitoring 05:21:20 INFO - Starting resource monitoring. 05:21:20 INFO - [mozharness: 2016-07-28 12:21:20.748181Z] Finished create-virtualenv step (success) 05:21:20 INFO - [mozharness: 2016-07-28 12:21:20.748625Z] Running install step. 05:21:20 INFO - Running pre-action listener: _resource_record_pre_action 05:21:20 INFO - Running main action method: install 05:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:20 INFO - Reading from file tmpfile_stdout 05:21:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:21 INFO - Reading from file tmpfile_stdout 05:21:21 INFO - Output received: 05:21:21 INFO - Usage: mozinstall [options] installer 05:21:21 INFO - Options: 05:21:21 INFO - -h, --help show this help message and exit 05:21:21 INFO - -d DEST, --destination=DEST 05:21:21 INFO - Directory to install application into. [default: 05:21:21 INFO - "/builds/slave/test"] 05:21:21 INFO - --app=APP Application being installed. [default: firefox] 05:21:21 INFO - mkdir: /builds/slave/test/build/application 05:21:21 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'] 05:21:21 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 05:21:38 INFO - Reading from file tmpfile_stdout 05:21:38 INFO - Output received: 05:21:38 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:38 INFO - Running post-action listener: _resource_record_post_action 05:21:38 INFO - [mozharness: 2016-07-28 12:21:38.326791Z] Finished install step (success) 05:21:38 INFO - [mozharness: 2016-07-28 12:21:38.327070Z] Running run-tests step. 05:21:38 INFO - Running pre-action listener: _resource_record_pre_action 05:21:38 INFO - Running main action method: run_tests 05:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:38 INFO - Python 2.7.3 05:21:38 INFO - Return code: 0 05:21:38 INFO - grabbing minidump binary from tooltool 05:21: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')]} 05:21: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 0x1cb03b0>, '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 0x1cb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21: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 05:21: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 05:21: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 05:21:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:38 INFO - Return code: 0 05:21:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 05:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 05:21:38 INFO - Using env: {'DISPLAY': ':0', 05:21:38 INFO - 'HOME': '/home/cltbld', 05:21:38 INFO - 'LANG': 'en_US.UTF-8', 05:21:38 INFO - 'LANGUAGE': 'en_US:en', 05:21:38 INFO - 'LOGNAME': 'cltbld', 05:21:38 INFO - 'MAIL': '/var/mail/cltbld', 05:21:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:38 INFO - 'MOZ_NO_REMOTE': '1', 05:21:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:38 INFO - 'NO_EM_RESTART': '1', 05:21:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:38 INFO - 'PWD': '/builds/slave/test', 05:21:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:38 INFO - 'SHELL': '/bin/bash', 05:21:38 INFO - 'SHLVL': '1', 05:21:38 INFO - 'TERM': 'linux', 05:21:38 INFO - 'TMOUT': '86400', 05:21:38 INFO - 'USER': 'cltbld', 05:21:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550', 05:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:38 INFO - '_': '/tools/buildbot/bin/python'} 05:21:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 05:21:38 INFO - mozversion application_buildid: 20160728023018 05:21:38 INFO - mozversion application_changeset: e82080019746478198c4009ba0c5c358be3f0359 05:21:38 INFO - mozversion application_display_name: Nightly 05:21:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:38 INFO - mozversion application_name: Firefox 05:21:38 INFO - mozversion application_remotingname: firefox 05:21:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:21:38 INFO - mozversion application_vendor: Mozilla 05:21:38 INFO - mozversion application_version: 50.0a1 05:21:38 INFO - mozversion platform_buildid: 20160728023018 05:21:38 INFO - mozversion platform_changeset: e82080019746478198c4009ba0c5c358be3f0359 05:21:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:21:38 INFO - mozversion platform_version: 50.0a1 05:21:38 INFO - using testdate: 1469708498 05:21:38 INFO - actual date: 1469708498 05:21:38 INFO - starting webserver on 'localhost:44871' 05:21:38 INFO - SUITE-START | Running 2 tests 05:21:38 INFO - TEST-START | dromaeo_css 05:21:38 INFO - operating with platform_type : linux_ 05:21:38 INFO - Initialising browser for dromaeo_css test... 05:21:38 INFO - TEST-INFO | started process 30942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprxv3Uw/profile http://localhost:44871/getInfo.html) 05:21:41 INFO - PROCESS | 30942 | JavaScript error: , line 0: uncaught exception: undefined 05:21:42 INFO - PROCESS | 30942 | __metrics Screen width/height:1600/1200 05:21:42 INFO - PROCESS | 30942 | colorDepth:24 05:21:42 INFO - PROCESS | 30942 | Browser inner width/height: 1024/697 05:21:42 INFO - PROCESS | 30942 | __metrics 05:21:42 INFO - PROCESS | 30942 | 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" 05:21:42 INFO - PROCESS | 30942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:43 INFO - TEST-INFO | 30942: exit 0 05:21:43 INFO - Browser initialized. 05:21:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:43 INFO - TEST-INFO | started process 31019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprxv3Uw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:55 INFO - PROCESS | 31019 | RSS: Main: 157945856 05:21:55 INFO - PROCESS | 31019 | 05:22:47 INFO - PROCESS | 31019 | 1469708567443 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] 05:24:55 INFO - PROCESS | 31019 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44871/tests/dromaeo/cssquery-ext.html) 05:24:56 INFO - PROCESS | 31019 | RSS: Main: 263966720 05:24:56 INFO - PROCESS | 31019 | 05:27:58 INFO - PROCESS | 31019 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-ext.html (next: http://localhost:44871/tests/dromaeo/cssquery-jquery.html) 05:27:59 INFO - PROCESS | 31019 | RSS: Main: 245125120 05:27:59 INFO - PROCESS | 31019 | 05:31:01 INFO - PROCESS | 31019 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44871/tests/dromaeo/cssquery-mootools.html) 05:31:01 INFO - PROCESS | 31019 | RSS: Main: 185372672 05:31:01 INFO - PROCESS | 31019 | 05:34:03 INFO - PROCESS | 31019 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44871/tests/dromaeo/cssquery-prototype.html) 05:34:04 INFO - PROCESS | 31019 | RSS: Main: 223727616 05:34:04 INFO - PROCESS | 31019 | 05:37:06 INFO - PROCESS | 31019 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44871/tests/dromaeo/cssquery-yui.html) 05:37:07 INFO - PROCESS | 31019 | RSS: Main: 185516032 05:37:07 INFO - PROCESS | 31019 | 05:40:09 INFO - PROCESS | 31019 | Cycle 1(1): loaded http://localhost:44871/tests/dromaeo/cssquery-yui.html (next: http://localhost:44871/tests/dromaeo/cssquery-dojo.html) 05:40:09 INFO - PROCESS | 31019 | RSS: Main: 280842240 05:40:09 INFO - PROCESS | 31019 | 05:40:09 INFO - PROCESS | 31019 | __start_tp_report 05:40:09 INFO - PROCESS | 31019 | _x_x_mozilla_page_load 05:40:09 INFO - PROCESS | 31019 | _x_x_mozilla_page_load_details 05:40:09 INFO - PROCESS | 31019 | |i|pagename|runs| 05:40:09 INFO - PROCESS | 31019 | |0;dojo.html;3064.2645765016396;3081.58398616187;3105.5341698745187;3106.1923899786057;3120.6879312068795;5209.635325527214;5249.737513124348;5263.921041184381;5356.437574054722;5381.4618538146215;5361.222622719703;5384.946150538493;5421.512063914247;5422.349318081826;5440.510354068133;4820.975895120519;4855.32025516428;4919.803207871681;4922.753862306889;5077.568406685417;5008.924866127011;5012.69923804571;5051.292819005343;5065.012322597095;5068.34111565496;4753.429588449391;4784.162771514971;4820.517948205186;4827.58965487934;4955.380577427822;4831.033793241366;4845.5881250093435;4858.319835223072;4930.531599498042;4943.777530011158;4849.151398505247;4866.659333846632;4887.315775791392;4906.901861962777;4926.975365123188;5204.739763011872;5229.477052294778;5402.972985135049;5438.91841622376;5439.374471935738;5604.663720176803;5628.943710562883;5633.436656334375;5639.71801409932;5643.351014633287;5665.631733937322;5701.2018317435595;5705.258316418881;5736.082226843685;5752.712364381806;5168.431472538018;5253.763580638919;5292.047431462373;5316.9202461963105;5363.597730170214;5896.734646940898;5906.852328691817;5907.616004959664;5913.970430147821;5915.970420147958;5645.802396916089;5646.265985421869;5648;5650.039493286151;5650.378458369576;5514.779408823682;5625.6905870176715;5656.179853921159;5695.316562012502;5728.942710572925;5685.175649530877;5693.373728889819;5694.9430505695245;5710.114932185518;5746.396628353963;5650.85872853182;5690.2887139107615;5695.03184458643;5697.971510142423;5699.088145896637;4221.451211342506;4298.054428025829;4370.169667763115;4371.5628437156665;4411.470623525198;3909.863154789569;3928.3714605663527;3978.244133614604;4002.3396139637216;4029.8589549365634;5493.395726470085;5496.835094947158;5506.146547285177;5511.283533140666;5512.5589952803675;5576.693281869455;5716.657000579979;5857.384974577693;5867.442592953663;5902.586818922634;5410.48600382963;5456.727163641802;5461.453854614507;5503.174523821459;5512.255845460892;4994.3507344045765;4994.475580064113;4998.1253280676465;5000.449950505442;5044.344235249468;5698.857528561819;5719.714014299185;5943.910841337383;5952.10718392236;5958.404159584007;5593.356763972195;5674.404187560412;5698.2592263005545;5713.028785106459;5770.192173095854;5863.560232982458;5866.2960444746905;5872.794452194324;5873.853153671193;5874.060150375919;5415.350157981067;5551.084071128219;5601.663900166003;5602.13166959122;5608.551315894801;5810.912836307543;5811.593188476935;5815.33123690764;5855.209546711139;5856.3558008618165;5560.165975103767;5571.05292100352;5574;5578.442155784389;5581.190727344593;5400.648957817729;5560.805371811967;5568.359638641608;5571.777128914798;5578.804741834017;5505.917411238915;5606.6916319602815;5609.186667933209;5623.2408624835125;5660.037793575185;5681.0910254359105;5699.2590963174525;5741.368449470639;5747.885042299215;5749.885002299847;5357.651752636066;5376.946230537645;5555.444455554412;5573.498385145356;5582.609217354746 05:40:09 INFO - PROCESS | 31019 | |1;ext.html;590.8316129902978;606.0696830365389;606.3572613030185;619.8574327904579;621.5804332075847;31412.842935785317;31830.68169318306;44845.551544484544;45834.083318333614;45906.770466147624;42420.36369454453;46961.53038469614;46971.76514117425;47012.76493617527;47017.294740578836;9087.818243635124;9239.07609239074;9244.352895297332;9245.399049061823;9249.028851970546;9013.54932253388;9084.40951338161;9096.772580685503;9109.68116115936;9110.451223292022;9125.315601329894;9158.358914875962;9174.17432431081;9175.816483670322;9180.265578753684;8927.776805579848;8929.06244844295;8935.910640893573;8936.463812171258;8939.553022348857;9029.458232506006;9125.908740912571;9127;9130.817383652357;9130.863037054449;43369;43661.56338436607;43771.78114109409;43825.34261986073;43833;3751.9812400938094;3814.7138964577766;3892.5134358205223;3946.052947292658;4061.5735347788645;33162.33675326504;33333.499997500054;34568;34609.653903460894;34639.307213855835;4368.868933931987;4438.178936896652;4501.932471012905;4640.65195110368;4649.04694537619;375425;376063;378534;378602.99999999726;379381;60001;60235;60587.69706151441;60724;60884;62293.68853155796;62442;62613;62637.060444093375;62723.37276627267;15230.314635841414;15381.461648842236;15391.307391167424;15397.153156576496;15414.614634634223;12012.399380030964;12080.335581542924;12103.213291136048;12109.152359334938;12115.091368147425;14929;17002.48992530226;17009.06450145254;17044.744328835077;17045.23296451663;6446.258680251737;6457.677116144174;6541.542092053605;6776.15298087739;6781.25406205317;812.8333691593209;816.6896579299828;848.240824462103;903.3631289940577;959.2949182350967;31400.528992065138;32271.67728322734;32773.18067048343;32850;33191.83404083012;863.7149740585592;1095.6986828622194;1119.0879433261866;1189.9821502677466;1209.5041033176356;16932.746008809878;17033.48899533016;17115.400960966308;17136.400225992278;17210.225539850737;579651;581706;586771;588836;588940;51449.74275128675;57144.42855571391;57378.42621573731;57552.136717949266;57581.42418575844;1298.8636193199768;1338.4713038349798;1364.7884577890443;1388.8402833674054;1403.4316101978716;31912.8404357986;34018.82990585031;34173.65826341705;34241.31517369689;34602.19375868602;51919.22121168261;52432;52506;52676.73661631667;52718;403216;405689;407792;795789;823126;27445.725542744316;27490.450190996467;27544.449111018068;27770.305742356602;27786.5832012524;46639.53360466352;47055.76472117617;47094;47144.057118858116;47384.289235660806;40193;40255.396169058076;40782.79608601938;41580.58419415767;41854.162916742105;40197.50421045732;40356;40388.394174087996;41516.79241603773;42072.57927420809;39853.40219896762;40315;43150.78424607983;44079.33880991724;44303.55696442995;34750.30499389947;36679;37321.521417430085;38053.61946380501;38064.7534220702;27593.586096208976;27765.444691105662;27823.721762782923;28314.85842570774;29792.70207297899 05:40:09 INFO - PROCESS | 31019 | |2;jquery.html;363.6363636363636;369.7079307347194;389.53645162256913;394.4911064726503;406.8982754311422;17251.741223881636;19069.427917162506;19096.140673669684;19295.903520482396;19652.312169074085;19770.703439448418;19831.801681983176;19868.801311986877;19975.800241997575;20310.89844550775;5046.293518907356;5589.972050139754;5668.546516278709;5793.131030345461;5798.826035218929;5614.9438505615035;5693.743781529841;5694.060480020791;5695.231143795597;5696.629719068268;5405.729713514328;5632.155176723483;5653.643125649835;5668.461496157858;5670.234518340033;5643.125315576071;5658.547316214735;5671.234383358276;5676.858078548049;5677.744501497443;4862.902741945141;5046.495350464961;5073.949260507385;5074.137396642543;5078.289039534431;23221.419464513354;23313.533729325318;23499.53000939989;23629.054837806467;23662;2328.092044102801;2348.4886210846175;2374.9406264843346;2602.622619720149;3155.4477966355794;14678.706425871424;14715.190664513555;14789.40842366304;14901.627459313604;15468.690626187414;1902.6765449873556;1977.2881762565464;2004.5790384019374;2005.44850166204;2057.0640358636783;58307;62426.37573624297;71819.64090179568;80941.38117237682;81241.18758812395;10471.84292235617;10633.946830265799;10643.361398316125;10663.146948244277;10837.891621083845;14653.780193297109;14790.852091478948;14893.77659335111;14966.700665986837;14969.925150374396;7704.30661240491;7895.447318687751;7912.643931023118;7938.841223175504;7960.2437768413065;7427.702891884264;7442.441816863757;7574.242575742382;7614.200508946592;7622.847543049108;6440.838979025468;6489.967550162313;6502.674866256668;6590.703418346186;6632.137822083098;1827.5613852675262;1839.1561636180447;1840.5153043391315;1876.9457970783044;1893.9715904261448;941.2940294778916;969.583079275904;1068.8183008888507;1092.6503518874042;1094.1520321750547;20347.59304813925;20667.17331306731;20733.27433539819;20909.984413315415;21158.78841211599;1000.8448690452991;1007.1690855044471;1008.1481148429565;1059.586761163147;1078.196743426137;11075.501602427748;11888.702782430508;11899.88100119005;11907.940460297816;11909.404529773477;483002;486390;488079;499277;503133;82627.17372826315;84463.5776821112;85144;85243.5737821307;86613.56693216493;987.7283746969641;1033.8552602635486;1040.95836166554;1063.5267306048734;1064.3135177810268;13551;17477.912610436866;17824.643507130044;18569.628607428047;18849.811501884804;40350.59649403468;40519.59480405158;40543.1891362177;40580.797096015514;41855.581444186384;49146.26280605865;50069.49930500648;50076.248856267914;50421.49578504168;50545.24182137197;8001.399895008014;8196.59017049157;8206.22040906113;8224.794380140544;8410.243078122998;10976.231663783778;11449;11820.113491488;12029.699257518632;12268.32524211177;9828.754281143028;10683.145348371956;10809.18931080188;10923.836142458029;11206.327620342805;10258.538365773707;10377.896221037994;10383.53274102652;10521.421321827373;10600.257981941499;10594.364338139736;10962.232643714864;11010.669679909615;11185.552577896793;11218.439078045902;7552.244775522624;7587.696492140473;7713.326179404617;7867.645955932111;7912.881306780518;9757.414555126716;10798.082163016232;11093.500792464198;11247.493862776359;11289.379084150121 05:40:09 INFO - PROCESS | 31019 | |3;mootools.html;1433.8351089624693;1511.478539903733;1605.8554730074297;1750.5011071844526;1761.8062013178555;8502.957485212573;9187.35688501805;9189.44863308202;9191.218746406546;9198.310126740487;7663.15705272421;7886.842263154734;7897.091834439041;8034.03591569011;8998.73003809885;2188.8248940084754;2257.3566533537946;2264.275431861805;2276.5788329159077;2282.3837563857833;2286.211257116292;2332.696749422573;2342.941426464335;2347.2019513365453;2351.2123438647986;2254.9323520294333;2261.6268315727966;2263.9320820375333;2268.6841631853567;2269.7503274639776;2201.7027701260286;2275.977240227593;2280.076568989562;2282.646189840569;2286.4283929017747;2273.8294627902974;2283.120998415622;2290.7594702556326;2297.6208925527267;2301.079568172744;9041.502717350542;9203.677871274473;9216.447013179231;9218.35471516994;9226.169644732006;5008.9499105008845;5159.58723302135;5160.071187186305;5161.071007218699;5165.819196328148;3108.8134711917355;3248.8538015789345;3268.656791036931;3277.3117645294515;3291.9835400822844;976.6564671015965;1029.1355261580234;1042.5777560088177;1049.8950104989517;1051.2378525568977;12475.50097996079;12569.183003104768;12581.622551323475;12596.937015314865;12626.30555319457;4209.957900420956;4278.4865816102265;4401.2517871961845;4404.823807047746;4637.466691330473;10654.89345106539;10667.306625069501;10668.30656007357;10670.786584268271;10690.518926648165;5281.445448227958;5285.9735701322015;5288.735563221823;5289.550388217045;5292.92060619091;4803.951960480351;4815.181419158752;4885.877853053702;4887.36464259644;4889.193283108248;3843.461915331856;3952.7825969571372;3963.4253033310583;3999.200159968018;4030.899227519277;1192.070185255502;1196.7785959597502;1221.2245224282467;1241.5158088345552;1250.8874201321926;948.5020364308793;961.6153538584482;974.2400927276735;983.8376667849868;986.524787429762;5840.591158618856;5853.297604287428;5875.41245875409;5877.38287479817;6049.939500605025;405.0784465341372;418.4845516872907;424.15592969990115;427.4293817753272;428.04332317270877;3866.6326698963553;3975.4434379186937;4005.9599404005585;4008.198360327946;4087.2438598859308;10670.786584268271;11065;11179.664610061549;11191.32852028881;11201.327920324806;10988.230823842414;11124.666260012213;11153.776924461465;11204.943975280072;11209.94395028036;8417.242448179572;8564.61459234336;8610.397272190887;8614.65541378338;8616.78458038554;5627.155926611041;5638.126090455986;5741.942580574141;5756.30924289088;5926.851828704317;10381.688549343531;10398.480075996322;10447.791044179226;10472.424016679155;10514.895935926923;10200.59197632116;10628.043476087189;10715.142788576739;10806.459677016275;10869.130469562575;7652.923470765221;7744.303012728881;7793.1427542969095;7807.102183248772;7814.6874125034365;8603.397762156588;8695.087015863497;8782.473051616924;8796.736097917073;8865.68970086044;7833.1775163607;7914.44598878073;7932.206779322021;7964.561949092856;8002.879956800536;7733.497322674233;7782.105057918186;7788.104367997753;7894.447388682966;7914.2085791420395;6576.079348891255;6828.419584335387;6868.141482314711;6886.552374095668;6896.586204827727;5039.521245481674;5169.327987361619;5173.22401639757;5251.632385732962;5265.394479634738;4925.532074452921;4977.402711674622;5203.27154198405;5241.109011467984;5287.656302340336 05:40:09 INFO - PROCESS | 31019 | |4;prototype.html;297.8972254572172;315.70797012763194;324.7369630599215;325.2210954763342;337.2883216413367;5193.55854752346;5292.947070529289;5312.043832110218;5330.520253177213;5375.220593014011;5081.33942587464;5273.2617433559335;5281.603879709028;5290.1800220965715;5310.787568497255;4181.874543763677;4202.684798640114;4216.641585465231;4240.872773816791;4247.15056988602;4014.759114453142;4024.979875100635;4147.751134931914;4170.874873753793;4178.373244013407;4099.262132816092;4101.302778527657;4105.938410923838;4120.752754834704;4123.402106694528;4148.62662360386;4148.958510414887;4153.8753837384775;4156.147989662112;4158.812853421603;3600.6939410150167;3651.598324184338;3658.579263384718;3697.6856967157555;3698.4267438547067;5134.897302053975;5135.460776618439;5138.434772175057;5142.845714628567;5151.381834179922;4688.601468875149;4689.343491911101;4693.647976401783;4693.835715749967;4717.103750287469;5200.089984252741;5438.966596346681;5469.644473109275;5473.370562385337;5483.588730845163;4005.639492445694;4009.69927255457;4013.257547353749;4047.1500984792933;4053.837846486137;5794.82615521535;5818.359980402152;5819.301683797929;5825.2233068913965;5825.9417405825825;4023.8591649292134;4102.4615769086595;4120.855770048034;4125.6591607727605;4129.421880936671;4150.6471949884;4159.542450330461;4160.479940007499;4179.331306990867;4182.059036716714;4480;4677.929831052537;4727.503612120747;4728.527147285313;4747.667663263538;5505.311836020497;5512.448755124456;5522.006038912954;5535.474129957647;5545.362283337387;1419.985800142006;1429.3639330498036;1445.2484707952017;1450.6083357493417;1455.5487798782199;950.0072424316605;966.2270183852889;969.345691658128;971.1502435369052;979.4955597867104;4759.881002974953;4774.427068751772;4783.736894470768;4814.6870453420415;4865.5864251539015;5025.597952163818;5050.898982020339;5062.670926389773;5127.974405118991;5130.7947682093045;4615.723056616546;4640;4644.606618014582;4736;4750.572448479654;2706.174616741913;2706.215197592676;2708.3229192701824;2709.701932787392;2713.525133101739;5168.741562921914;5183.807724223449;5191.195364718475;5194.896102077937;5206.791728330824;5158.974205129025;5346.705931173745;5816.447437493516;5887.381824908409;5891;5905.350411454737;5925.348211696796;5932.970335148297;5938.6436813791315;5939;5559.805406810742;5695.800646977336;5769;5842.474177324061;5847.502962248256;5675.545956323567;5680.147977803363;5685.175649530712;5689.516391106802;5700.543956483554;5925.1704761332585;5932.8813423732145;5938.109283607493;5944.554158438048;5984.820455386345;3967.504061992251;4104.856330028435;4105.322621767375;4134.462519872397;4148.585141485827;5489.58828087887;5559.360673522435;5690.402507736628;5798.710064496842;5804.2744656917885;5555.8888822224135;5572.498475137257;5575.804846830341;5639.830805075854;5645.096784514458;5545.195946587803;5569.944300557105;5592.965301419251;5607.186957891165;5643.802466913638;5275.314209152939;5434.266374039454;5516.724163791714;5521.171824226398;5528.612997090165;5540.86147846291;5561.5272701820795;5585.525230355465;5604.131359639263;5654.208410822571;5270.578353731769;5447.155690867922;5480.671159730429;5491.670499770026;5495.670259784266 05:40:09 INFO - PROCESS | 31019 | |5;yui.html;715.4062128433401;788.1921030943282;794.1621589223371;805.8670319397299;809.0534075132095;14781.630459238524;15160.393584256617;15790.447334343286;15790.684186316266;17501.299948002095;13494.662633434169;13498;13534.458621655147;13599.38802753876;13606.455741770318;655.446148004935;794.9443538952276;812.2486699802688;813.8738495533172;814.1817473439215;795.5306369242146;824.9876251856197;826.0541679776652;826.499967519651;829.4152622401193;864.6714248585529;865.5109862927458;866.2766589897443;866.7963028688254;868.2186032570673;694.9131358580178;854.337888136699;856.9614367353485;858.1590041759049;859.7291853066264;608;624.3257282135284;626.029654036242;626.7586979013067;626.8370223741814;15315.846841531553;15438.45965391206;15471.458498952483;15482.22588870552;15490;14660.853391466162;14901.105933644016;14929.925350373178;14945.850541494554;15036;13490.662733431645;13577.45690172392;13678.863211367958;13878.583642490741;13881.861181388158;4708.411448568929;4717.787699553528;4796.616270698336;4804.279358096279;4929.186684197103;74841.6257918707;74953;75023.24976750217;79794.99999999942;80350.59824700838;11453.312801231952;11792.41037948099;11825.763484730429;11853.762924741457;12207.206531575419;22128.557428851334;22137.335879923627;22216;22297.108115675517;22322.21872234464;8857;8885.42244754089;9027.77430564228;9115.947937278215;9149.451032937912;4793.158909501359;4941.258811178352;4994.300797888299;5004.599632029429;5022.573081288058;3558.377283975294;3656.305301992613;3656.4149736042104;3664.2854643344826;3674.283514714605;583.4515555377931;590.6751286792334;595.4938302442976;597.7579080472416;599.9400059993966;584.9970750146222;665.4942243894578;688.7141836137947;692.5844493303978;707.752286699651;9661.372010819274;9976.102150806462;10019.198464122852;10324.535395907202;10440;596.6777939912399;651.3974573519475;704.0600797934712;706.9646517674198;746.1792028768311;4755.714657120515;4856.223004319292;4893.388326459192;4915.65590408668;4976.552110310089;115104;117400;117500;119727;123328.38335808444;101598.49200753949;101903.49048254712;103403.48298258611;104149;106166.46916765366;52067.47932520702;64958.675206623666;80793.19206807975;81219.59390203012;81351.59324203341;8891.866622000805;9127.680531181377;9132.132447417485;9136.406133601295;9474.763130921781;38000.34993876116;48898;51398;52359.47640523699;53575.732121340705;70267.64866175842;74747;75295;75658;76259.8561021574;11663.358515281741;11915.52337906474;11939.462724177607;11985.843883959655;12036.277823330629;12210.6947326314;12285.385730713608;12526.264026107792;12598.3070931096;12910.354482275661;12562.497500100259;12599.748005040032;12671.936640317108;12770.489180433051;12915.289659068842;12451.937740311241;12651.93674031624;12735.108542401942;12748.745025099632;12864.614061578168;12145.514179433078;12549.43527541281;12567.748645027232;12670.619881403572;12674.429650665557;10678.89321106779;10763.623273185402;11100.278481898651;11115.888841111486;11413.486393112164;11219.326840389604;11261.718457038312;11277.887221127683;11287.153463490107;11363.261388009752 05:40:09 INFO - PROCESS | 31019 | __end_tp_report 05:40:09 INFO - PROCESS | 31019 | __start_cc_report 05:40:09 INFO - PROCESS | 31019 | _x_x_mozilla_cycle_collect,973 05:40:10 INFO - PROCESS | 31019 | __end_cc_report 05:40:10 INFO - PROCESS | 31019 | __startTimestamp1469709609990__endTimestamp 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - PROCESS | 31019 | ------- Summary: start ------- 05:40:10 INFO - PROCESS | 31019 | Number of tests: 6 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - PROCESS | 31019 | [#0] dojo.html Cycles:165 Average:5324.26 Median:5555.44 stddev:594.79 (10.7%) stddev-sans-first:569.58 05:40:10 INFO - PROCESS | 31019 | Values: 3064.3 3081.6 3105.5 3106.2 3120.7 5209.6 5249.7 5263.9 5356.4 5381.5 5361.2 5384.9 5421.5 5422.3 5440.5 4821.0 4855.3 4919.8 4922.8 5077.6 5008.9 5012.7 5051.3 5065.0 5068.3 4753.4 4784.2 4820.5 4827.6 4955.4 4831.0 4845.6 4858.3 4930.5 4943.8 4849.2 4866.7 4887.3 4906.9 4927.0 5204.7 5229.5 5403.0 5438.9 5439.4 5604.7 5628.9 5633.4 5639.7 5643.4 5665.6 5701.2 5705.3 5736.1 5752.7 5168.4 5253.8 5292.0 5316.9 5363.6 5896.7 5906.9 5907.6 5914.0 5916.0 5645.8 5646.3 5648.0 5650.0 5650.4 5514.8 5625.7 5656.2 5695.3 5728.9 5685.2 5693.4 5694.9 5710.1 5746.4 5650.9 5690.3 5695.0 5698.0 5699.1 4221.5 4298.1 4370.2 4371.6 4411.5 3909.9 3928.4 3978.2 4002.3 4029.9 5493.4 5496.8 5506.1 5511.3 5512.6 5576.7 5716.7 5857.4 5867.4 5902.6 5410.5 5456.7 5461.5 5503.2 5512.3 4994.4 4994.5 4998.1 5000.4 5044.3 5698.9 5719.7 5943.9 5952.1 5958.4 5593.4 5674.4 5698.3 5713.0 5770.2 5863.6 5866.3 5872.8 5873.9 5874.1 5415.4 5551.1 5601.7 5602.1 5608.6 5810.9 5811.6 5815.3 5855.2 5856.4 5560.2 5571.1 5574.0 5578.4 5581.2 5400.6 5560.8 5568.4 5571.8 5578.8 5505.9 5606.7 5609.2 5623.2 5660.0 5681.1 5699.3 5741.4 5747.9 5749.9 5357.7 5376.9 5555.4 5573.5 5582.6 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - PROCESS | 31019 | [#1] ext.html Cycles:180 Average:66148.81 Median:24070.33 stddev:142074.99 (590.2%) stddev-sans-first:142388.29 05:40:10 INFO - PROCESS | 31019 | Values: 590.8 606.1 606.4 619.9 621.6 31412.8 31830.7 44845.6 45834.1 45906.8 42420.4 46961.5 46971.8 47012.8 47017.3 9087.8 9239.1 9244.4 9245.4 9249.0 9013.5 9084.4 9096.8 9109.7 9110.5 9125.3 9158.4 9174.2 9175.8 9180.3 8927.8 8929.1 8935.9 8936.5 8939.6 9029.5 9125.9 9127.0 9130.8 9130.9 43369.0 43661.6 43771.8 43825.3 43833.0 3752.0 3814.7 3892.5 3946.1 4061.6 33162.3 33333.5 34568.0 34609.7 34639.3 4368.9 4438.2 4501.9 4640.7 4649.0 375425.0 376063.0 378534.0 378603.0 379381.0 60001.0 60235.0 60587.7 60724.0 60884.0 62293.7 62442.0 62613.0 62637.1 62723.4 15230.3 15381.5 15391.3 15397.2 15414.6 12012.4 12080.3 12103.2 12109.2 12115.1 14929.0 17002.5 17009.1 17044.7 17045.2 6446.3 6457.7 6541.5 6776.2 6781.3 812.8 816.7 848.2 903.4 959.3 31400.5 32271.7 32773.2 32850.0 33191.8 863.7 1095.7 1119.1 1190.0 1209.5 16932.7 17033.5 17115.4 17136.4 17210.2 579651.0 581706.0 586771.0 588836.0 588940.0 51449.7 57144.4 57378.4 57552.1 57581.4 1298.9 1338.5 1364.8 1388.8 1403.4 31912.8 34018.8 34173.7 34241.3 34602.2 51919.2 52432.0 52506.0 52676.7 52718.0 403216.0 405689.0 407792.0 795789.0 823126.0 27445.7 27490.5 27544.4 27770.3 27786.6 46639.5 47055.8 47094.0 47144.1 47384.3 40193.0 40255.4 40782.8 41580.6 41854.2 40197.5 40356.0 40388.4 41516.8 42072.6 39853.4 40315.0 43150.8 44079.3 44303.6 34750.3 36679.0 37321.5 38053.6 38064.8 27593.6 27765.4 27823.7 28314.9 29792.7 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - PROCESS | 31019 | [#2] jquery.html Cycles:180 Average:28361.59 Median:23645.53 stddev:80747.06 (341.5%) stddev-sans-first:80946.21 05:40:10 INFO - PROCESS | 31019 | Values: 363.6 369.7 389.5 394.5 406.9 17251.7 19069.4 19096.1 19295.9 19652.3 19770.7 19831.8 19868.8 19975.8 20310.9 5046.3 5590.0 5668.5 5793.1 5798.8 5614.9 5693.7 5694.1 5695.2 5696.6 5405.7 5632.2 5653.6 5668.5 5670.2 5643.1 5658.5 5671.2 5676.9 5677.7 4862.9 5046.5 5073.9 5074.1 5078.3 23221.4 23313.5 23499.5 23629.1 23662.0 2328.1 2348.5 2374.9 2602.6 3155.4 14678.7 14715.2 14789.4 14901.6 15468.7 1902.7 1977.3 2004.6 2005.4 2057.1 58307.0 62426.4 71819.6 80941.4 81241.2 10471.8 10633.9 10643.4 10663.1 10837.9 14653.8 14790.9 14893.8 14966.7 14969.9 7704.3 7895.4 7912.6 7938.8 7960.2 7427.7 7442.4 7574.2 7614.2 7622.8 6440.8 6490.0 6502.7 6590.7 6632.1 1827.6 1839.2 1840.5 1876.9 1894.0 941.3 969.6 1068.8 1092.7 1094.2 20347.6 20667.2 20733.3 20910.0 21158.8 1000.8 1007.2 1008.1 1059.6 1078.2 11075.5 11888.7 11899.9 11907.9 11909.4 483002.0 486390.0 488079.0 499277.0 503133.0 82627.2 84463.6 85144.0 85243.6 86613.6 987.7 1033.9 1041.0 1063.5 1064.3 13551.0 17477.9 17824.6 18569.6 18849.8 40350.6 40519.6 40543.2 40580.8 41855.6 49146.3 50069.5 50076.2 50421.5 50545.2 8001.4 8196.6 8206.2 8224.8 8410.2 10976.2 11449.0 11820.1 12029.7 12268.3 9828.8 10683.1 10809.2 10923.8 11206.3 10258.5 10377.9 10383.5 10521.4 10600.3 10594.4 10962.2 11010.7 11185.6 11218.4 7552.2 7587.7 7713.3 7867.6 7912.9 9757.4 10798.1 11093.5 11247.5 11289.4 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - PROCESS | 31019 | [#3] mootools.html Cycles:180 Average:5831.82 Median:2414.65 stddev:3431.30 (142.1%) stddev-sans-first:3425.01 05:40:10 INFO - PROCESS | 31019 | Values: 1433.8 1511.5 1605.9 1750.5 1761.8 8503.0 9187.4 9189.4 9191.2 9198.3 7663.2 7886.8 7897.1 8034.0 8998.7 2188.8 2257.4 2264.3 2276.6 2282.4 2286.2 2332.7 2342.9 2347.2 2351.2 2254.9 2261.6 2263.9 2268.7 2269.8 2201.7 2276.0 2280.1 2282.6 2286.4 2273.8 2283.1 2290.8 2297.6 2301.1 9041.5 9203.7 9216.4 9218.4 9226.2 5008.9 5159.6 5160.1 5161.1 5165.8 3108.8 3248.9 3268.7 3277.3 3292.0 976.7 1029.1 1042.6 1049.9 1051.2 12475.5 12569.2 12581.6 12596.9 12626.3 4210.0 4278.5 4401.3 4404.8 4637.5 10654.9 10667.3 10668.3 10670.8 10690.5 5281.4 5286.0 5288.7 5289.6 5292.9 4804.0 4815.2 4885.9 4887.4 4889.2 3843.5 3952.8 3963.4 3999.2 4030.9 1192.1 1196.8 1221.2 1241.5 1250.9 948.5 961.6 974.2 983.8 986.5 5840.6 5853.3 5875.4 5877.4 6049.9 405.1 418.5 424.2 427.4 428.0 3866.6 3975.4 4006.0 4008.2 4087.2 10670.8 11065.0 11179.7 11191.3 11201.3 10988.2 11124.7 11153.8 11204.9 11209.9 8417.2 8564.6 8610.4 8614.7 8616.8 5627.2 5638.1 5741.9 5756.3 5926.9 10381.7 10398.5 10447.8 10472.4 10514.9 10200.6 10628.0 10715.1 10806.5 10869.1 7652.9 7744.3 7793.1 7807.1 7814.7 8603.4 8695.1 8782.5 8796.7 8865.7 7833.2 7914.4 7932.2 7964.6 8002.9 7733.5 7782.1 7788.1 7894.4 7914.2 6576.1 6828.4 6868.1 6886.6 6896.6 5039.5 5169.3 5173.2 5251.6 5265.4 4925.5 4977.4 5203.3 5241.1 5287.7 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - PROCESS | 31019 | [#4] prototype.html Cycles:180 Average:4608.08 Median:5155.18 stddev:1352.32 (26.2%) stddev-sans-first:1316.85 05:40:10 INFO - PROCESS | 31019 | Values: 297.9 315.7 324.7 325.2 337.3 5193.6 5292.9 5312.0 5330.5 5375.2 5081.3 5273.3 5281.6 5290.2 5310.8 4181.9 4202.7 4216.6 4240.9 4247.2 4014.8 4025.0 4147.8 4170.9 4178.4 4099.3 4101.3 4105.9 4120.8 4123.4 4148.6 4149.0 4153.9 4156.1 4158.8 3600.7 3651.6 3658.6 3697.7 3698.4 5134.9 5135.5 5138.4 5142.8 5151.4 4688.6 4689.3 4693.6 4693.8 4717.1 5200.1 5439.0 5469.6 5473.4 5483.6 4005.6 4009.7 4013.3 4047.2 4053.8 5794.8 5818.4 5819.3 5825.2 5825.9 4023.9 4102.5 4120.9 4125.7 4129.4 4150.6 4159.5 4160.5 4179.3 4182.1 4480.0 4677.9 4727.5 4728.5 4747.7 5505.3 5512.4 5522.0 5535.5 5545.4 1420.0 1429.4 1445.2 1450.6 1455.5 950.0 966.2 969.3 971.2 979.5 4759.9 4774.4 4783.7 4814.7 4865.6 5025.6 5050.9 5062.7 5128.0 5130.8 4615.7 4640.0 4644.6 4736.0 4750.6 2706.2 2706.2 2708.3 2709.7 2713.5 5168.7 5183.8 5191.2 5194.9 5206.8 5159.0 5346.7 5816.4 5887.4 5891.0 5905.4 5925.3 5933.0 5938.6 5939.0 5559.8 5695.8 5769.0 5842.5 5847.5 5675.5 5680.1 5685.2 5689.5 5700.5 5925.2 5932.9 5938.1 5944.6 5984.8 3967.5 4104.9 4105.3 4134.5 4148.6 5489.6 5559.4 5690.4 5798.7 5804.3 5555.9 5572.5 5575.8 5639.8 5645.1 5545.2 5569.9 5593.0 5607.2 5643.8 5275.3 5434.3 5516.7 5521.2 5528.6 5540.9 5561.5 5585.5 5604.1 5654.2 5270.6 5447.2 5480.7 5491.7 5495.7 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - PROCESS | 31019 | [#5] yui.html Cycles:180 Average:20545.12 Median:4736.75 stddev:29858.10 (630.3%) stddev-sans-first:29904.73 05:40:10 INFO - PROCESS | 31019 | Values: 715.4 788.2 794.2 805.9 809.1 14781.6 15160.4 15790.4 15790.7 17501.3 13494.7 13498.0 13534.5 13599.4 13606.5 655.4 794.9 812.2 813.9 814.2 795.5 825.0 826.1 826.5 829.4 864.7 865.5 866.3 866.8 868.2 694.9 854.3 857.0 858.2 859.7 608.0 624.3 626.0 626.8 626.8 15315.8 15438.5 15471.5 15482.2 15490.0 14660.9 14901.1 14929.9 14945.9 15036.0 13490.7 13577.5 13678.9 13878.6 13881.9 4708.4 4717.8 4796.6 4804.3 4929.2 74841.6 74953.0 75023.2 79795.0 80350.6 11453.3 11792.4 11825.8 11853.8 12207.2 22128.6 22137.3 22216.0 22297.1 22322.2 8857.0 8885.4 9027.8 9115.9 9149.5 4793.2 4941.3 4994.3 5004.6 5022.6 3558.4 3656.3 3656.4 3664.3 3674.3 583.5 590.7 595.5 597.8 599.9 585.0 665.5 688.7 692.6 707.8 9661.4 9976.1 10019.2 10324.5 10440.0 596.7 651.4 704.1 707.0 746.2 4755.7 4856.2 4893.4 4915.7 4976.6 115104.0 117400.0 117500.0 119727.0 123328.4 101598.5 101903.5 103403.5 104149.0 106166.5 52067.5 64958.7 80793.2 81219.6 81351.6 8891.9 9127.7 9132.1 9136.4 9474.8 38000.3 48898.0 51398.0 52359.5 53575.7 70267.6 74747.0 75295.0 75658.0 76259.9 11663.4 11915.5 11939.5 11985.8 12036.3 12210.7 12285.4 12526.3 12598.3 12910.4 12562.5 12599.7 12671.9 12770.5 12915.3 12451.9 12651.9 12735.1 12748.7 12864.6 12145.5 12549.4 12567.7 12670.6 12674.4 10678.9 10763.6 11100.3 11115.9 11413.5 11219.3 11261.7 11277.9 11287.2 11363.3 05:40:10 INFO - PROCESS | 31019 | -------- Summary: end -------- 05:40:10 INFO - PROCESS | 31019 | 05:40:10 INFO - TEST-INFO | 31019: exit 0 05:40:10 INFO - TEST-OK | dromaeo_css | took 1112217ms 05:40:10 INFO - TEST-START | kraken 05:40:10 INFO - operating with platform_type : linux_ 05:40:10 INFO - Initialising browser for kraken test... 05:40:10 INFO - TEST-INFO | started process 31207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFmT1wd/profile http://localhost:44871/getInfo.html) 05:40:13 INFO - PROCESS | 31207 | JavaScript error: , line 0: uncaught exception: undefined 05:40:14 INFO - PROCESS | 31207 | __metrics Screen width/height:1600/1200 05:40:14 INFO - PROCESS | 31207 | colorDepth:24 05:40:14 INFO - PROCESS | 31207 | Browser inner width/height: 1024/697 05:40:14 INFO - PROCESS | 31207 | __metrics 05:40:15 INFO - PROCESS | 31207 | 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" 05:40:15 INFO - PROCESS | 31207 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:15 INFO - TEST-INFO | 31207: exit 0 05:40:15 INFO - Browser initialized. 05:40:15 INFO - Running cycle 1/1 for kraken test... 05:40:15 INFO - TEST-INFO | started process 31289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFmT1wd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:27 INFO - PROCESS | 31289 | RSS: Main: 158052352 05:40:27 INFO - PROCESS | 31289 | 05:40:30 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:31 INFO - PROCESS | 31289 | RSS: Main: 214544384 05:40:31 INFO - PROCESS | 31289 | 05:40:33 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-dft) 05:40:34 INFO - PROCESS | 31289 | RSS: Main: 193269760 05:40:34 INFO - PROCESS | 31289 | 05:40:37 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-fft) 05:40:38 INFO - PROCESS | 31289 | RSS: Main: 271994880 05:40:38 INFO - PROCESS | 31289 | 05:40:40 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44871/tests/kraken/driver.html?testName=audio-oscillator) 05:40:40 INFO - PROCESS | 31289 | RSS: Main: 180899840 05:40:40 INFO - PROCESS | 31289 | 05:40:42 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:43 INFO - PROCESS | 31289 | RSS: Main: 185331712 05:40:43 INFO - PROCESS | 31289 | 05:40:46 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44871/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:47 INFO - PROCESS | 31289 | RSS: Main: 220438528 05:40:47 INFO - PROCESS | 31289 | 05:40:50 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44871/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:51 INFO - PROCESS | 31289 | RSS: Main: 221175808 05:40:51 INFO - PROCESS | 31289 | 05:40:53 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44871/tests/kraken/driver.html?testName=json-parse-financial) 05:40:54 INFO - PROCESS | 31289 | RSS: Main: 220987392 05:40:54 INFO - PROCESS | 31289 | 05:40:55 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:56 INFO - PROCESS | 31289 | RSS: Main: 185507840 05:40:56 INFO - PROCESS | 31289 | 05:40:58 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:58 INFO - PROCESS | 31289 | RSS: Main: 190607360 05:40:58 INFO - PROCESS | 31289 | 05:41:00 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:01 INFO - PROCESS | 31289 | RSS: Main: 194998272 05:41:01 INFO - PROCESS | 31289 | 05:41:04 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:04 INFO - PROCESS | 31289 | RSS: Main: 191676416 05:41:04 INFO - PROCESS | 31289 | 05:41:07 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:08 INFO - PROCESS | 31289 | RSS: Main: 194666496 05:41:08 INFO - PROCESS | 31289 | 05:41:09 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:44871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44871/tests/kraken/driver.html?testName=ai-astar) 05:41:10 INFO - PROCESS | 31289 | RSS: Main: 245166080 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | __start_tp_report 05:41:10 INFO - PROCESS | 31289 | _x_x_mozilla_page_load 05:41:10 INFO - PROCESS | 31289 | _x_x_mozilla_page_load_details 05:41:10 INFO - PROCESS | 31289 | |i|pagename|runs| 05:41:10 INFO - PROCESS | 31289 | |0;ai-astar;102;111;110;112;121;111;109;111;111;111 05:41:10 INFO - PROCESS | 31289 | |1;audio-beat-detection;142;121;118;181;118;124;142;118;154;121 05:41:10 INFO - PROCESS | 31289 | |2;audio-dft;161;159;160;160;161;159;161;163;162;160 05:41:10 INFO - PROCESS | 31289 | |3;audio-fft;74;77;74;107;76;75;74;74;97;74 05:41:10 INFO - PROCESS | 31289 | |4;audio-oscillator;85;83;122;83;84;84;113;83;83;122 05:41:10 INFO - PROCESS | 31289 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;116 05:41:10 INFO - PROCESS | 31289 | |6;imaging-darkroom;146;146;147;146;146;146;146;145;145;146 05:41:10 INFO - PROCESS | 31289 | |7;imaging-desaturate;96;96;96;96;94;95;95;95;95;95 05:41:10 INFO - PROCESS | 31289 | |8;json-parse-financial;52;52;52;53;52;52;52;53;51;52 05:41:10 INFO - PROCESS | 31289 | |9;json-stringify-tinderbox;63;64;62;63;63;63;63;63;63;64 05:41:10 INFO - PROCESS | 31289 | |10;stanford-crypto-aes;78;76;77;76;82;79;82;75;77;81 05:41:10 INFO - PROCESS | 31289 | |11;stanford-crypto-ccm;125;134;126;122;122;121;139;128;159;128 05:41:10 INFO - PROCESS | 31289 | |12;stanford-crypto-pbkdf2;160;160;159;158;156;158;164;163;162;162 05:41:10 INFO - PROCESS | 31289 | |13;stanford-crypto-sha256-iterative;65;66;63;62;63;64;63;64;62;61 05:41:10 INFO - PROCESS | 31289 | __end_tp_report 05:41:10 INFO - PROCESS | 31289 | __start_cc_report 05:41:10 INFO - PROCESS | 31289 | _x_x_mozilla_cycle_collect,1718 05:41:10 INFO - PROCESS | 31289 | __end_cc_report 05:41:10 INFO - PROCESS | 31289 | __startTimestamp1469709670031__endTimestamp 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | ------- Summary: start ------- 05:41:10 INFO - PROCESS | 31289 | Number of tests: 14 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.56 (4.1%) stddev-sans-first:3.52 05:41:10 INFO - PROCESS | 31289 | Values: 102.0 111.0 110.0 112.0 121.0 111.0 109.0 111.0 111.0 111.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:133.00 stddev:20.93 (15.7%) stddev-sans-first:21.99 05:41:10 INFO - PROCESS | 31289 | Values: 142.0 121.0 118.0 181.0 118.0 124.0 142.0 118.0 154.0 121.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 05:41:10 INFO - PROCESS | 31289 | Values: 161.0 159.0 160.0 160.0 161.0 159.0 161.0 163.0 162.0 160.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.50 stddev:11.77 (15.8%) stddev-sans-first:12.27 05:41:10 INFO - PROCESS | 31289 | Values: 74.0 77.0 74.0 107.0 76.0 75.0 74.0 74.0 97.0 74.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:83.00 stddev:17.30 (20.8%) stddev-sans-first:18.03 05:41:10 INFO - PROCESS | 31289 | Values: 85.0 83.0 122.0 83.0 84.0 84.0 113.0 83.0 83.0 122.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:41:10 INFO - PROCESS | 31289 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:41:10 INFO - PROCESS | 31289 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:41:10 INFO - PROCESS | 31289 | Values: 96.0 96.0 96.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 05:41:10 INFO - PROCESS | 31289 | Values: 52.0 52.0 52.0 53.0 52.0 52.0 52.0 53.0 51.0 52.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 05:41:10 INFO - PROCESS | 31289 | Values: 63.0 64.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:2.58 (3.3%) stddev-sans-first:2.74 05:41:10 INFO - PROCESS | 31289 | Values: 78.0 76.0 77.0 76.0 82.0 79.0 82.0 75.0 77.0 81.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:128.00 stddev:11.52 (9.0%) stddev-sans-first:12.05 05:41:10 INFO - PROCESS | 31289 | Values: 125.0 134.0 126.0 122.0 122.0 121.0 139.0 128.0 159.0 128.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.00 stddev:2.53 (1.6%) stddev-sans-first:2.68 05:41:10 INFO - PROCESS | 31289 | Values: 160.0 160.0 159.0 158.0 156.0 158.0 164.0 163.0 162.0 162.0 05:41:10 INFO - PROCESS | 31289 | 05:41:10 INFO - PROCESS | 31289 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.49 (2.4%) stddev-sans-first:1.45 05:41:10 INFO - PROCESS | 31289 | Values: 65.0 66.0 63.0 62.0 63.0 64.0 63.0 64.0 62.0 61.0 05:41:10 INFO - PROCESS | 31289 | -------- Summary: end -------- 05:41:10 INFO - PROCESS | 31289 | 05:41:11 INFO - TEST-INFO | 31289: exit 0 05:41:11 INFO - TEST-OK | kraken | took 60296ms 05:41:11 INFO - SUITE-END | took 1172s 05:41:11 INFO - Completed test suite (00:19:32) 05:41:11 INFO - javascript benchmark 05:41:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.2645765016396, 3081.58398616187, 3105.5341698745187, 3106.1923899786057, 3120.6879312068795, 5209.635325527214, 5249.737513124348, 5263.921041184381, 5356.437574054722, 5381.4618538146215, 5361.222622719703, 5384.946150538493, 5421.512063914247, 5422.349318081826, 5440.510354068133, 4820.975895120519, 4855.32025516428, 4919.803207871681, 4922.753862306889, 5077.568406685417, 5008.924866127011, 5012.69923804571, 5051.292819005343, 5065.012322597095, 5068.34111565496, 4753.429588449391, 4784.162771514971, 4820.517948205186, 4827.58965487934, 4955.380577427822, 4831.033793241366, 4845.5881250093435, 4858.319835223072, 4930.531599498042, 4943.777530011158, 4849.151398505247, 4866.659333846632, 4887.315775791392, 4906.901861962777, 4926.975365123188, 5204.739763011872, 5229.477052294778, 5402.972985135049, 5438.91841622376, 5439.374471935738, 5604.663720176803, 5628.943710562883, 5633.436656334375, 5639.71801409932, 5643.351014633287, 5665.631733937322, 5701.2018317435595, 5705.258316418881, 5736.082226843685, 5752.712364381806, 5168.431472538018, 5253.763580638919, 5292.047431462373, 5316.9202461963105, 5363.597730170214, 5896.734646940898, 5906.852328691817, 5907.616004959664, 5913.970430147821, 5915.970420147958, 5645.802396916089, 5646.265985421869, 5648.0, 5650.039493286151, 5650.378458369576, 5514.779408823682, 5625.6905870176715, 5656.179853921159, 5695.316562012502, 5728.942710572925, 5685.175649530877, 5693.373728889819, 5694.9430505695245, 5710.114932185518, 5746.396628353963, 5650.85872853182, 5690.2887139107615, 5695.03184458643, 5697.971510142423, 5699.088145896637, 4221.451211342506, 4298.054428025829, 4370.169667763115, 4371.5628437156665, 4411.470623525198, 3909.863154789569, 3928.3714605663527, 3978.244133614604, 4002.3396139637216, 4029.8589549365634, 5493.395726470085, 5496.835094947158, 5506.146547285177, 5511.283533140666, 5512.5589952803675, 5576.693281869455, 5716.657000579979, 5857.384974577693, 5867.442592953663, 5902.586818922634, 5410.48600382963, 5456.727163641802, 5461.453854614507, 5503.174523821459, 5512.255845460892, 4994.3507344045765, 4994.475580064113, 4998.1253280676465, 5000.449950505442, 5044.344235249468, 5698.857528561819, 5719.714014299185, 5943.910841337383, 5952.10718392236, 5958.404159584007, 5593.356763972195, 5674.404187560412, 5698.2592263005545, 5713.028785106459, 5770.192173095854, 5863.560232982458, 5866.2960444746905, 5872.794452194324, 5873.853153671193, 5874.060150375919, 5415.350157981067, 5551.084071128219, 5601.663900166003, 5602.13166959122, 5608.551315894801, 5810.912836307543, 5811.593188476935, 5815.33123690764, 5855.209546711139, 5856.3558008618165, 5560.165975103767, 5571.05292100352, 5574.0, 5578.442155784389, 5581.190727344593, 5400.648957817729, 5560.805371811967, 5568.359638641608, 5571.777128914798, 5578.804741834017, 5505.917411238915, 5606.6916319602815, 5609.186667933209, 5623.2408624835125, 5660.037793575185, 5681.0910254359105, 5699.2590963174525, 5741.368449470639, 5747.885042299215, 5749.885002299847, 5357.651752636066, 5376.946230537645, 5555.444455554412, 5573.498385145356, 5582.609217354746], "value": 5284.6146531775485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.8316129902978, 606.0696830365389, 606.3572613030185, 619.8574327904579, 621.5804332075847, 31412.842935785317, 31830.68169318306, 44845.551544484544, 45834.083318333614, 45906.770466147624, 42420.36369454453, 46961.53038469614, 46971.76514117425, 47012.76493617527, 47017.294740578836, 9087.818243635124, 9239.07609239074, 9244.352895297332, 9245.399049061823, 9249.028851970546, 9013.54932253388, 9084.40951338161, 9096.772580685503, 9109.68116115936, 9110.451223292022, 9125.315601329894, 9158.358914875962, 9174.17432431081, 9175.816483670322, 9180.265578753684, 8927.776805579848, 8929.06244844295, 8935.910640893573, 8936.463812171258, 8939.553022348857, 9029.458232506006, 9125.908740912571, 9127.0, 9130.817383652357, 9130.863037054449, 43369.0, 43661.56338436607, 43771.78114109409, 43825.34261986073, 43833.0, 3751.9812400938094, 3814.7138964577766, 3892.5134358205223, 3946.052947292658, 4061.5735347788645, 33162.33675326504, 33333.499997500054, 34568.0, 34609.653903460894, 34639.307213855835, 4368.868933931987, 4438.178936896652, 4501.932471012905, 4640.65195110368, 4649.04694537619, 375425.0, 376063.0, 378534.0, 378602.99999999726, 379381.0, 60001.0, 60235.0, 60587.69706151441, 60724.0, 60884.0, 62293.68853155796, 62442.0, 62613.0, 62637.060444093375, 62723.37276627267, 15230.314635841414, 15381.461648842236, 15391.307391167424, 15397.153156576496, 15414.614634634223, 12012.399380030964, 12080.335581542924, 12103.213291136048, 12109.152359334938, 12115.091368147425, 14929.0, 17002.48992530226, 17009.06450145254, 17044.744328835077, 17045.23296451663, 6446.258680251737, 6457.677116144174, 6541.542092053605, 6776.15298087739, 6781.25406205317, 812.8333691593209, 816.6896579299828, 848.240824462103, 903.3631289940577, 959.2949182350967, 31400.528992065138, 32271.67728322734, 32773.18067048343, 32850.0, 33191.83404083012, 863.7149740585592, 1095.6986828622194, 1119.0879433261866, 1189.9821502677466, 1209.5041033176356, 16932.746008809878, 17033.48899533016, 17115.400960966308, 17136.400225992278, 17210.225539850737, 579651.0, 581706.0, 586771.0, 588836.0, 588940.0, 51449.74275128675, 57144.42855571391, 57378.42621573731, 57552.136717949266, 57581.42418575844, 1298.8636193199768, 1338.4713038349798, 1364.7884577890443, 1388.8402833674054, 1403.4316101978716, 31912.8404357986, 34018.82990585031, 34173.65826341705, 34241.31517369689, 34602.19375868602, 51919.22121168261, 52432.0, 52506.0, 52676.73661631667, 52718.0, 403216.0, 405689.0, 407792.0, 795789.0, 823126.0, 27445.725542744316, 27490.450190996467, 27544.449111018068, 27770.305742356602, 27786.5832012524, 46639.53360466352, 47055.76472117617, 47094.0, 47144.057118858116, 47384.289235660806, 40193.0, 40255.396169058076, 40782.79608601938, 41580.58419415767, 41854.162916742105, 40197.50421045732, 40356.0, 40388.394174087996, 41516.79241603773, 42072.57927420809, 39853.40219896762, 40315.0, 43150.78424607983, 44079.33880991724, 44303.55696442995, 34750.30499389947, 36679.0, 37321.521417430085, 38053.61946380501, 38064.7534220702, 27593.586096208976, 27765.444691105662, 27823.721762782923, 28314.85842570774, 29792.70207297899], "value": 20322.321083706327, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.6363636363636, 369.7079307347194, 389.53645162256913, 394.4911064726503, 406.8982754311422, 17251.741223881636, 19069.427917162506, 19096.140673669684, 19295.903520482396, 19652.312169074085, 19770.703439448418, 19831.801681983176, 19868.801311986877, 19975.800241997575, 20310.89844550775, 5046.293518907356, 5589.972050139754, 5668.546516278709, 5793.131030345461, 5798.826035218929, 5614.9438505615035, 5693.743781529841, 5694.060480020791, 5695.231143795597, 5696.629719068268, 5405.729713514328, 5632.155176723483, 5653.643125649835, 5668.461496157858, 5670.234518340033, 5643.125315576071, 5658.547316214735, 5671.234383358276, 5676.858078548049, 5677.744501497443, 4862.902741945141, 5046.495350464961, 5073.949260507385, 5074.137396642543, 5078.289039534431, 23221.419464513354, 23313.533729325318, 23499.53000939989, 23629.054837806467, 23662.0, 2328.092044102801, 2348.4886210846175, 2374.9406264843346, 2602.622619720149, 3155.4477966355794, 14678.706425871424, 14715.190664513555, 14789.40842366304, 14901.627459313604, 15468.690626187414, 1902.6765449873556, 1977.2881762565464, 2004.5790384019374, 2005.44850166204, 2057.0640358636783, 58307.0, 62426.37573624297, 71819.64090179568, 80941.38117237682, 81241.18758812395, 10471.84292235617, 10633.946830265799, 10643.361398316125, 10663.146948244277, 10837.891621083845, 14653.780193297109, 14790.852091478948, 14893.77659335111, 14966.700665986837, 14969.925150374396, 7704.30661240491, 7895.447318687751, 7912.643931023118, 7938.841223175504, 7960.2437768413065, 7427.702891884264, 7442.441816863757, 7574.242575742382, 7614.200508946592, 7622.847543049108, 6440.838979025468, 6489.967550162313, 6502.674866256668, 6590.703418346186, 6632.137822083098, 1827.5613852675262, 1839.1561636180447, 1840.5153043391315, 1876.9457970783044, 1893.9715904261448, 941.2940294778916, 969.583079275904, 1068.8183008888507, 1092.6503518874042, 1094.1520321750547, 20347.59304813925, 20667.17331306731, 20733.27433539819, 20909.984413315415, 21158.78841211599, 1000.8448690452991, 1007.1690855044471, 1008.1481148429565, 1059.586761163147, 1078.196743426137, 11075.501602427748, 11888.702782430508, 11899.88100119005, 11907.940460297816, 11909.404529773477, 483002.0, 486390.0, 488079.0, 499277.0, 503133.0, 82627.17372826315, 84463.5776821112, 85144.0, 85243.5737821307, 86613.56693216493, 987.7283746969641, 1033.8552602635486, 1040.95836166554, 1063.5267306048734, 1064.3135177810268, 13551.0, 17477.912610436866, 17824.643507130044, 18569.628607428047, 18849.811501884804, 40350.59649403468, 40519.59480405158, 40543.1891362177, 40580.797096015514, 41855.581444186384, 49146.26280605865, 50069.49930500648, 50076.248856267914, 50421.49578504168, 50545.24182137197, 8001.399895008014, 8196.59017049157, 8206.22040906113, 8224.794380140544, 8410.243078122998, 10976.231663783778, 11449.0, 11820.113491488, 12029.699257518632, 12268.32524211177, 9828.754281143028, 10683.145348371956, 10809.18931080188, 10923.836142458029, 11206.327620342805, 10258.538365773707, 10377.896221037994, 10383.53274102652, 10521.421321827373, 10600.257981941499, 10594.364338139736, 10962.232643714864, 11010.669679909615, 11185.552577896793, 11218.439078045902, 7552.244775522624, 7587.696492140473, 7713.326179404617, 7867.645955932111, 7912.881306780518, 9757.414555126716, 10798.082163016232, 11093.500792464198, 11247.493862776359, 11289.379084150121], "value": 9153.935870215906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.8351089624693, 1511.478539903733, 1605.8554730074297, 1750.5011071844526, 1761.8062013178555, 8502.957485212573, 9187.35688501805, 9189.44863308202, 9191.218746406546, 9198.310126740487, 7663.15705272421, 7886.842263154734, 7897.091834439041, 8034.03591569011, 8998.73003809885, 2188.8248940084754, 2257.3566533537946, 2264.275431861805, 2276.5788329159077, 2282.3837563857833, 2286.211257116292, 2332.696749422573, 2342.941426464335, 2347.2019513365453, 2351.2123438647986, 2254.9323520294333, 2261.6268315727966, 2263.9320820375333, 2268.6841631853567, 2269.7503274639776, 2201.7027701260286, 2275.977240227593, 2280.076568989562, 2282.646189840569, 2286.4283929017747, 2273.8294627902974, 2283.120998415622, 2290.7594702556326, 2297.6208925527267, 2301.079568172744, 9041.502717350542, 9203.677871274473, 9216.447013179231, 9218.35471516994, 9226.169644732006, 5008.9499105008845, 5159.58723302135, 5160.071187186305, 5161.071007218699, 5165.819196328148, 3108.8134711917355, 3248.8538015789345, 3268.656791036931, 3277.3117645294515, 3291.9835400822844, 976.6564671015965, 1029.1355261580234, 1042.5777560088177, 1049.8950104989517, 1051.2378525568977, 12475.50097996079, 12569.183003104768, 12581.622551323475, 12596.937015314865, 12626.30555319457, 4209.957900420956, 4278.4865816102265, 4401.2517871961845, 4404.823807047746, 4637.466691330473, 10654.89345106539, 10667.306625069501, 10668.30656007357, 10670.786584268271, 10690.518926648165, 5281.445448227958, 5285.9735701322015, 5288.735563221823, 5289.550388217045, 5292.92060619091, 4803.951960480351, 4815.181419158752, 4885.877853053702, 4887.36464259644, 4889.193283108248, 3843.461915331856, 3952.7825969571372, 3963.4253033310583, 3999.200159968018, 4030.899227519277, 1192.070185255502, 1196.7785959597502, 1221.2245224282467, 1241.5158088345552, 1250.8874201321926, 948.5020364308793, 961.6153538584482, 974.2400927276735, 983.8376667849868, 986.524787429762, 5840.591158618856, 5853.297604287428, 5875.41245875409, 5877.38287479817, 6049.939500605025, 405.0784465341372, 418.4845516872907, 424.15592969990115, 427.4293817753272, 428.04332317270877, 3866.6326698963553, 3975.4434379186937, 4005.9599404005585, 4008.198360327946, 4087.2438598859308, 10670.786584268271, 11065.0, 11179.664610061549, 11191.32852028881, 11201.327920324806, 10988.230823842414, 11124.666260012213, 11153.776924461465, 11204.943975280072, 11209.94395028036, 8417.242448179572, 8564.61459234336, 8610.397272190887, 8614.65541378338, 8616.78458038554, 5627.155926611041, 5638.126090455986, 5741.942580574141, 5756.30924289088, 5926.851828704317, 10381.688549343531, 10398.480075996322, 10447.791044179226, 10472.424016679155, 10514.895935926923, 10200.59197632116, 10628.043476087189, 10715.142788576739, 10806.459677016275, 10869.130469562575, 7652.923470765221, 7744.303012728881, 7793.1427542969095, 7807.102183248772, 7814.6874125034365, 8603.397762156588, 8695.087015863497, 8782.473051616924, 8796.736097917073, 8865.68970086044, 7833.1775163607, 7914.44598878073, 7932.206779322021, 7964.561949092856, 8002.879956800536, 7733.497322674233, 7782.105057918186, 7788.104367997753, 7894.447388682966, 7914.2085791420395, 6576.079348891255, 6828.419584335387, 6868.141482314711, 6886.552374095668, 6896.586204827727, 5039.521245481674, 5169.327987361619, 5173.22401639757, 5251.632385732962, 5265.394479634738, 4925.532074452921, 4977.402711674622, 5203.27154198405, 5241.109011467984, 5287.656302340336], "value": 4529.245124691278, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.8972254572172, 315.70797012763194, 324.7369630599215, 325.2210954763342, 337.2883216413367, 5193.55854752346, 5292.947070529289, 5312.043832110218, 5330.520253177213, 5375.220593014011, 5081.33942587464, 5273.2617433559335, 5281.603879709028, 5290.1800220965715, 5310.787568497255, 4181.874543763677, 4202.684798640114, 4216.641585465231, 4240.872773816791, 4247.15056988602, 4014.759114453142, 4024.979875100635, 4147.751134931914, 4170.874873753793, 4178.373244013407, 4099.262132816092, 4101.302778527657, 4105.938410923838, 4120.752754834704, 4123.402106694528, 4148.62662360386, 4148.958510414887, 4153.8753837384775, 4156.147989662112, 4158.812853421603, 3600.6939410150167, 3651.598324184338, 3658.579263384718, 3697.6856967157555, 3698.4267438547067, 5134.897302053975, 5135.460776618439, 5138.434772175057, 5142.845714628567, 5151.381834179922, 4688.601468875149, 4689.343491911101, 4693.647976401783, 4693.835715749967, 4717.103750287469, 5200.089984252741, 5438.966596346681, 5469.644473109275, 5473.370562385337, 5483.588730845163, 4005.639492445694, 4009.69927255457, 4013.257547353749, 4047.1500984792933, 4053.837846486137, 5794.82615521535, 5818.359980402152, 5819.301683797929, 5825.2233068913965, 5825.9417405825825, 4023.8591649292134, 4102.4615769086595, 4120.855770048034, 4125.6591607727605, 4129.421880936671, 4150.6471949884, 4159.542450330461, 4160.479940007499, 4179.331306990867, 4182.059036716714, 4480.0, 4677.929831052537, 4727.503612120747, 4728.527147285313, 4747.667663263538, 5505.311836020497, 5512.448755124456, 5522.006038912954, 5535.474129957647, 5545.362283337387, 1419.985800142006, 1429.3639330498036, 1445.2484707952017, 1450.6083357493417, 1455.5487798782199, 950.0072424316605, 966.2270183852889, 969.345691658128, 971.1502435369052, 979.4955597867104, 4759.881002974953, 4774.427068751772, 4783.736894470768, 4814.6870453420415, 4865.5864251539015, 5025.597952163818, 5050.898982020339, 5062.670926389773, 5127.974405118991, 5130.7947682093045, 4615.723056616546, 4640.0, 4644.606618014582, 4736.0, 4750.572448479654, 2706.174616741913, 2706.215197592676, 2708.3229192701824, 2709.701932787392, 2713.525133101739, 5168.741562921914, 5183.807724223449, 5191.195364718475, 5194.896102077937, 5206.791728330824, 5158.974205129025, 5346.705931173745, 5816.447437493516, 5887.381824908409, 5891.0, 5905.350411454737, 5925.348211696796, 5932.970335148297, 5938.6436813791315, 5939.0, 5559.805406810742, 5695.800646977336, 5769.0, 5842.474177324061, 5847.502962248256, 5675.545956323567, 5680.147977803363, 5685.175649530712, 5689.516391106802, 5700.543956483554, 5925.1704761332585, 5932.8813423732145, 5938.109283607493, 5944.554158438048, 5984.820455386345, 3967.504061992251, 4104.856330028435, 4105.322621767375, 4134.462519872397, 4148.585141485827, 5489.58828087887, 5559.360673522435, 5690.402507736628, 5798.710064496842, 5804.2744656917885, 5555.8888822224135, 5572.498475137257, 5575.804846830341, 5639.830805075854, 5645.096784514458, 5545.195946587803, 5569.944300557105, 5592.965301419251, 5607.186957891165, 5643.802466913638, 5275.314209152939, 5434.266374039454, 5516.724163791714, 5521.171824226398, 5528.612997090165, 5540.86147846291, 5561.5272701820795, 5585.525230355465, 5604.131359639263, 5654.208410822571, 5270.578353731769, 5447.155690867922, 5480.671159730429, 5491.670499770026, 5495.670259784266], "value": 4178.278448442305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.4062128433401, 788.1921030943282, 794.1621589223371, 805.8670319397299, 809.0534075132095, 14781.630459238524, 15160.393584256617, 15790.447334343286, 15790.684186316266, 17501.299948002095, 13494.662633434169, 13498.0, 13534.458621655147, 13599.38802753876, 13606.455741770318, 655.446148004935, 794.9443538952276, 812.2486699802688, 813.8738495533172, 814.1817473439215, 795.5306369242146, 824.9876251856197, 826.0541679776652, 826.499967519651, 829.4152622401193, 864.6714248585529, 865.5109862927458, 866.2766589897443, 866.7963028688254, 868.2186032570673, 694.9131358580178, 854.337888136699, 856.9614367353485, 858.1590041759049, 859.7291853066264, 608.0, 624.3257282135284, 626.029654036242, 626.7586979013067, 626.8370223741814, 15315.846841531553, 15438.45965391206, 15471.458498952483, 15482.22588870552, 15490.0, 14660.853391466162, 14901.105933644016, 14929.925350373178, 14945.850541494554, 15036.0, 13490.662733431645, 13577.45690172392, 13678.863211367958, 13878.583642490741, 13881.861181388158, 4708.411448568929, 4717.787699553528, 4796.616270698336, 4804.279358096279, 4929.186684197103, 74841.6257918707, 74953.0, 75023.24976750217, 79794.99999999942, 80350.59824700838, 11453.312801231952, 11792.41037948099, 11825.763484730429, 11853.762924741457, 12207.206531575419, 22128.557428851334, 22137.335879923627, 22216.0, 22297.108115675517, 22322.21872234464, 8857.0, 8885.42244754089, 9027.77430564228, 9115.947937278215, 9149.451032937912, 4793.158909501359, 4941.258811178352, 4994.300797888299, 5004.599632029429, 5022.573081288058, 3558.377283975294, 3656.305301992613, 3656.4149736042104, 3664.2854643344826, 3674.283514714605, 583.4515555377931, 590.6751286792334, 595.4938302442976, 597.7579080472416, 599.9400059993966, 584.9970750146222, 665.4942243894578, 688.7141836137947, 692.5844493303978, 707.752286699651, 9661.372010819274, 9976.102150806462, 10019.198464122852, 10324.535395907202, 10440.0, 596.6777939912399, 651.3974573519475, 704.0600797934712, 706.9646517674198, 746.1792028768311, 4755.714657120515, 4856.223004319292, 4893.388326459192, 4915.65590408668, 4976.552110310089, 115104.0, 117400.0, 117500.0, 119727.0, 123328.38335808444, 101598.49200753949, 101903.49048254712, 103403.48298258611, 104149.0, 106166.46916765366, 52067.47932520702, 64958.675206623666, 80793.19206807975, 81219.59390203012, 81351.59324203341, 8891.866622000805, 9127.680531181377, 9132.132447417485, 9136.406133601295, 9474.763130921781, 38000.34993876116, 48898.0, 51398.0, 52359.47640523699, 53575.732121340705, 70267.64866175842, 74747.0, 75295.0, 75658.0, 76259.8561021574, 11663.358515281741, 11915.52337906474, 11939.462724177607, 11985.843883959655, 12036.277823330629, 12210.6947326314, 12285.385730713608, 12526.264026107792, 12598.3070931096, 12910.354482275661, 12562.497500100259, 12599.748005040032, 12671.936640317108, 12770.489180433051, 12915.289659068842, 12451.937740311241, 12651.93674031624, 12735.108542401942, 12748.745025099632, 12864.614061578168, 12145.514179433078, 12549.43527541281, 12567.748645027232, 12670.619881403572, 12674.429650665557, 10678.89321106779, 10763.623273185402, 11100.278481898651, 11115.888841111486, 11413.486393112164, 11219.326840389604, 11261.718457038312, 11277.887221127683, 11287.153463490107, 11363.261388009752], "value": 7519.011570420694, "unit": "score"}], "name": "dromaeo_css", "value": 7205.059328983627, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 112.0, 121.0, 111.0, 109.0, 111.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 118.0, 181.0, 118.0, 124.0, 142.0, 118.0, 154.0, 121.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 161.0, 159.0, 161.0, 163.0, 162.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 107.0, 76.0, 75.0, 74.0, 74.0, 97.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 122.0, 83.0, 84.0, 84.0, 113.0, 83.0, 83.0, 122.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 52.0, 52.0, 52.0, 53.0, 51.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 76.0, 82.0, 79.0, 82.0, 75.0, 77.0, 81.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 134.0, 126.0, 122.0, 122.0, 121.0, 139.0, 128.0, 159.0, 128.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 158.0, 156.0, 158.0, 164.0, 163.0, 162.0, 162.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 63.0, 62.0, 63.0, 64.0, 63.0, 64.0, 62.0, 61.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1485.3999999999999, "alertThreshold": 2.0}]} 05:41:11 INFO - Return code: 0 05:41:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:41:11 INFO - # TBPL SUCCESS # 05:41:11 INFO - Running post-action listener: _resource_record_post_action 05:41:11 INFO - [mozharness: 2016-07-28 12:41:11.368372Z] Finished run-tests step (success) 05:41:11 INFO - Running post-run listener: _resource_record_post_run 05:41:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561651712; Read time: 12; Write time: 487580 05:41:11 INFO - TinderboxPrint: CPU usage
13.0% 05:41:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:41:11 INFO - TinderboxPrint: I/O write bytes / time
561,651,712 / 487,580 05:41:11 INFO - TinderboxPrint: CPU idle
8,260.3 (87.0%) 05:41:11 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 05:41:11 INFO - TinderboxPrint: Swap in / out
0 / 0 05:41:11 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 267509760; Read time: 0; Write time: 265428 05:41:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 293957632; Read time: 0; Write time: 222108 05:41:11 INFO - Running post-run listener: _upload_blobber_files 05:41:11 INFO - Blob upload gear active. 05:41:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:11 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 05:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:13 INFO - (blobuploader) - INFO - Done attempting. 05:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:13 INFO - (blobuploader) - INFO - Done attempting. 05:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:17 INFO - (blobuploader) - INFO - Done attempting. 05:41:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:17 INFO - Return code: 0 05:41:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9d5d43812278765466231815947f033ebea68729cfea9b74d6974af2d03d23f6bed5a5dd4e4585d5eccd6e290144e3618958a3213a48acbae37dbb8089d580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1c6e518f3d548d175db8244494c79b6afeb0e58a4307a723330599a4b709f29e697d7979232b60f4151387866c8a582dcaadd9a0a41bc23959bcbbbbc302f22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f01f7c314be250ad1cd88b3e0b1aebceff8e78558f55b0560bddb8eec899f0af5a81e0f33e7cbc348fe95b347c18b4f9c11c382277be1b88f06e01fdbf00ed8f"} 05:41:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:17 INFO - Contents: 05:41:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9d5d43812278765466231815947f033ebea68729cfea9b74d6974af2d03d23f6bed5a5dd4e4585d5eccd6e290144e3618958a3213a48acbae37dbb8089d580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1c6e518f3d548d175db8244494c79b6afeb0e58a4307a723330599a4b709f29e697d7979232b60f4151387866c8a582dcaadd9a0a41bc23959bcbbbbc302f22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f01f7c314be250ad1cd88b3e0b1aebceff8e78558f55b0560bddb8eec899f0af5a81e0f33e7cbc348fe95b347c18b4f9c11c382277be1b88f06e01fdbf00ed8f"} 05:41:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:17 INFO - Copying logs to upload dir... 05:41:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.967104 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-28 05:41:16.767916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 05:41:16.773804) ========= 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=0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9d5d43812278765466231815947f033ebea68729cfea9b74d6974af2d03d23f6bed5a5dd4e4585d5eccd6e290144e3618958a3213a48acbae37dbb8089d580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1c6e518f3d548d175db8244494c79b6afeb0e58a4307a723330599a4b709f29e697d7979232b60f4151387866c8a582dcaadd9a0a41bc23959bcbbbbc302f22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f01f7c314be250ad1cd88b3e0b1aebceff8e78558f55b0560bddb8eec899f0af5a81e0f33e7cbc348fe95b347c18b4f9c11c382277be1b88f06e01fdbf00ed8f"} build_url:https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9d5d43812278765466231815947f033ebea68729cfea9b74d6974af2d03d23f6bed5a5dd4e4585d5eccd6e290144e3618958a3213a48acbae37dbb8089d580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1c6e518f3d548d175db8244494c79b6afeb0e58a4307a723330599a4b709f29e697d7979232b60f4151387866c8a582dcaadd9a0a41bc23959bcbbbbc302f22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f01f7c314be250ad1cd88b3e0b1aebceff8e78558f55b0560bddb8eec899f0af5a81e0f33e7cbc348fe95b347c18b4f9c11c382277be1b88f06e01fdbf00ed8f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 05:41:16.801178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:41:16.801527) ========= 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=0333a256a5e4f052382dd180000001b1-1469708447.164392-1595586550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:41:16.885262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 05:41:16.885585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 05:41:16.885879) ========= ========= Total master_lag: 0.18 =========