builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1463712932.81 results: success (0) buildid: 20160519184305 builduid: cd341bfa9ed74804b7af33acbbf8b700 revision: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.809463) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.809973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.810399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.824641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.824955) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 19:55:33-- 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% 46.8M=0s 2016-05-19 19:55:33 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.925383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.925691) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021917 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.976145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:32.976526) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c67dc1f9fab86d4f2cf3224307809c44fe3ce820 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c67dc1f9fab86d4f2cf3224307809c44fe3ce820 --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=78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 19:55:33,212 truncating revision to first 12 chars 2016-05-19 19:55:33,212 Setting DEBUG logging. 2016-05-19 19:55:33,212 attempt 1/10 2016-05-19 19:55:33,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c67dc1f9fab8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 19:55:33,499 unpacking tar archive at: mozilla-central-c67dc1f9fab8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584808 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:33.575272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:33.575608) ========= script_repo_revision: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:33.576024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:33.576299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 19:55:33.584926) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-19 19:55:33.585309) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:55:33 INFO - MultiFileLogger online at 20160519 19:55:33 in /builds/slave/test 19:55:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:55:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:55:33 INFO - {'append_to_log': False, 19:55:33 INFO - 'base_work_dir': '/builds/slave/test', 19:55:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:55:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:55:33 INFO - 'branch': 'Firefox-Non-PGO', 19:55:33 INFO - 'buildbot_json_path': 'buildprops.json', 19:55:33 INFO - 'config_files': ('talos/linux_config.py',), 19:55:33 INFO - 'default_actions': ('clobber', 19:55:33 INFO - 'read-buildbot-config', 19:55:33 INFO - 'download-and-extract', 19:55:33 INFO - 'populate-webroot', 19:55:33 INFO - 'create-virtualenv', 19:55:33 INFO - 'install', 19:55:33 INFO - 'run-tests'), 19:55:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:55:33 INFO - 'download_minidump_stackwalk': True, 19:55:33 INFO - 'download_symbols': 'ondemand', 19:55:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:55:33 INFO - 'tooltool.py': '/tools/tooltool.py', 19:55:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:55:33 INFO - '/tools/misc-python/virtualenv.py')}, 19:55:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:55:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:55:33 INFO - 'installer_path': 'installer.exe', 19:55:33 INFO - 'log_level': 'info', 19:55:33 INFO - 'log_name': 'talos', 19:55:33 INFO - 'log_to_console': True, 19:55:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:55:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:55:33 INFO - 'opt_config_files': (), 19:55:33 INFO - 'pip_index': False, 19:55:33 INFO - 'sps_profile': False, 19:55:33 INFO - 'sps_profile_interval': 0, 19:55:33 INFO - 'suite': 'dromaeojs', 19:55:33 INFO - 'system_bits': '32', 19:55:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:55:33 INFO - 'title': 'talos-linux64-ix-019', 19:55:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:55:33 INFO - 'use_talos_json': True, 19:55:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:55:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:55:33 INFO - 'work_dir': 'build'} 19:55:33 INFO - ##### 19:55:33 INFO - ##### Running clobber step. 19:55:33 INFO - ##### 19:55:33 INFO - Running pre-action listener: _resource_record_pre_action 19:55:33 INFO - Running main action method: clobber 19:55:33 INFO - rmtree: /builds/slave/test/build 19:55:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:55:34 INFO - Running post-action listener: _resource_record_post_action 19:55:34 INFO - ##### 19:55:34 INFO - ##### Finished clobber step (success) 19:55:34 INFO - ##### 19:55:34 INFO - ##### 19:55:34 INFO - ##### Running read-buildbot-config step. 19:55:34 INFO - ##### 19:55:34 INFO - Running pre-action listener: _resource_record_pre_action 19:55:34 INFO - Running main action method: read_buildbot_config 19:55:34 INFO - Using buildbot properties: 19:55:34 INFO - { 19:55:34 INFO - "project": "", 19:55:34 INFO - "product": "firefox", 19:55:34 INFO - "script_repo_revision": "production", 19:55:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:55:34 INFO - "repository": "", 19:55:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 19:55:34 INFO - "buildid": "20160519184305", 19:55:34 INFO - "pgo_build": "False", 19:55:34 INFO - "basedir": "/builds/slave/test", 19:55:34 INFO - "buildnumber": 510, 19:55:34 INFO - "slavename": "talos-linux64-ix-019", 19:55:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:55:34 INFO - "platform": "ubuntu64_hw", 19:55:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:55:34 INFO - "branch": "mozilla-central", 19:55:34 INFO - "repo_path": "mozilla-central", 19:55:34 INFO - "revision": "c67dc1f9fab86d4f2cf3224307809c44fe3ce820", 19:55:34 INFO - "stage_platform": "linux64", 19:55:34 INFO - "builduid": "cd341bfa9ed74804b7af33acbbf8b700", 19:55:34 INFO - "slavebuilddir": "test" 19:55:34 INFO - } 19:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:55:34 INFO - Running post-action listener: _resource_record_post_action 19:55:34 INFO - ##### 19:55:34 INFO - ##### Finished read-buildbot-config step (success) 19:55:34 INFO - ##### 19:55:34 INFO - ##### 19:55:34 INFO - ##### Running download-and-extract step. 19:55:34 INFO - ##### 19:55:34 INFO - Running pre-action listener: _resource_record_pre_action 19:55:34 INFO - Running main action method: download_and_extract 19:55:34 INFO - mkdir: /builds/slave/test/build/tests 19:55:34 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')]} 19:55:34 INFO - https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:55:35 INFO - Downloaded 1361 bytes. 19:55:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:55:35 INFO - Using the following test package requirements: 19:55:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:55:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:55:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'jsshell-linux-x86_64.zip'], 19:55:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:55:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:55:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:55:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:55:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:55:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:35 INFO - https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:55:36 INFO - Downloaded 22813601 bytes. 19:55:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:55:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:55:37 INFO - Return code: 0 19:55:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:37 INFO - https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:55:39 INFO - Downloaded 22813601 bytes. 19:55:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:55:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:55:40 INFO - Return code: 0 19:55:40 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')]} 19:55:40 INFO - https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:55:41 INFO - Downloaded 10840359 bytes. 19:55:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:55:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:55:42 INFO - Return code: 0 19:55:42 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')]} 19:55:42 INFO - https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:55:44 INFO - Downloaded 54807603 bytes. 19:55:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:44 INFO - mkdir: /builds/slave/test/properties 19:55:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:55:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:55:44 INFO - Contents: 19:55:44 INFO - build_url:https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:45 INFO - Running post-action listener: _resource_record_post_action 19:55:45 INFO - Running post-action listener: set_extra_try_arguments 19:55:45 INFO - ##### 19:55:45 INFO - ##### Finished download-and-extract step (success) 19:55:45 INFO - ##### 19:55:45 INFO - ##### 19:55:45 INFO - ##### Running populate-webroot step. 19:55:45 INFO - ##### 19:55:45 INFO - Running pre-action listener: _resource_record_pre_action 19:55:45 INFO - Running main action method: populate_webroot 19:55:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:55:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:55:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:55:45 INFO - '--tppagecycles', 19:55:45 INFO - '7'], 19:55:45 INFO - 'tests': ['tsvgm']}}, 19:55:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:55:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:55:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:55:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:55:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['damp', 'tps']}, 19:55:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'tests': ['damp', 'tps']}, 19:55:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['dromaeo_dom']}, 19:55:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:55:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['a11yr', 19:55:45 INFO - 'ts_paint', 19:55:45 INFO - 'tpaint', 19:55:45 INFO - 'sessionrestore', 19:55:45 INFO - 'sessionrestore_no_auto_restore', 19:55:45 INFO - 'tabpaint']}, 19:55:45 INFO - 'other-e10s': {'tests': ['a11yr', 19:55:45 INFO - 'ts_paint', 19:55:45 INFO - 'tpaint', 19:55:45 INFO - 'sessionrestore', 19:55:45 INFO - 'sessionrestore_no_auto_restore', 19:55:45 INFO - 'tabpaint']}, 19:55:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:55:45 INFO - 'ts_paint', 19:55:45 INFO - 'tpaint', 19:55:45 INFO - 'sessionrestore', 19:55:45 INFO - 'sessionrestore_no_auto_restore', 19:55:45 INFO - 'tabpaint']}, 19:55:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:55:45 INFO - 'ts_paint', 19:55:45 INFO - 'tpaint', 19:55:45 INFO - 'sessionrestore', 19:55:45 INFO - 'sessionrestore_no_auto_restore', 19:55:45 INFO - 'tabpaint']}, 19:55:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['a11yr', 19:55:45 INFO - 'ts_paint', 19:55:45 INFO - 'tpaint', 19:55:45 INFO - 'sessionrestore', 19:55:45 INFO - 'sessionrestore_no_auto_restore', 19:55:45 INFO - 'tabpaint']}, 19:55:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['a11yr', 19:55:45 INFO - 'ts_paint', 19:55:45 INFO - 'tpaint', 19:55:45 INFO - 'sessionrestore', 19:55:45 INFO - 'sessionrestore_no_auto_restore', 19:55:45 INFO - 'tabpaint']}, 19:55:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['tsvgx', 19:55:45 INFO - 'tsvgr_opacity', 19:55:45 INFO - 'tart', 19:55:45 INFO - 'tscrollx', 19:55:45 INFO - 'cart']}, 19:55:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:55:45 INFO - 'tsvgr_opacity', 19:55:45 INFO - 'tart', 19:55:45 INFO - 'tscrollx', 19:55:45 INFO - 'cart']}, 19:55:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'talos_options': ['--disable-e10s'], 19:55:45 INFO - 'tests': ['tp5o']}, 19:55:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'tests': ['tp5o']}, 19:55:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'talos_options': ['--disable-e10s', 19:55:45 INFO - '--xperf_path', 19:55:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:45 INFO - 'tests': ['tp5n']}, 19:55:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:45 INFO - 'talos_options': ['--xperf_path', 19:55:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:45 INFO - 'tests': ['tp5n']}}, 19:55:45 INFO - 'talos.zip': {'path': '', 19:55:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:55:45 INFO - Running post-action listener: _resource_record_post_action 19:55:45 INFO - ##### 19:55:45 INFO - ##### Finished populate-webroot step (success) 19:55:45 INFO - ##### 19:55:45 INFO - ##### 19:55:45 INFO - ##### Running create-virtualenv step. 19:55:45 INFO - ##### 19:55:45 INFO - Running pre-action listener: _resource_record_pre_action 19:55:45 INFO - Running main action method: create_virtualenv 19:55:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:55:45 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 19:55:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:55:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:55:45 INFO - Using real prefix '/usr' 19:55:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:55:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:55:47 INFO - Installing pip.................done. 19:55:47 INFO - Return code: 0 19:55:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:55:47 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')]} 19:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:47 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')]} 19:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:47 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 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:55:47 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 19:55:47 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 19:55:47 INFO - Using env: {'DISPLAY': ':0', 19:55:47 INFO - 'HOME': '/home/cltbld', 19:55:47 INFO - 'LANG': 'en_US.UTF-8', 19:55:47 INFO - 'LANGUAGE': 'en_US:en', 19:55:47 INFO - 'LOGNAME': 'cltbld', 19:55:47 INFO - 'MAIL': '/var/mail/cltbld', 19:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:47 INFO - 'MOZ_NO_REMOTE': '1', 19:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:47 INFO - 'NO_EM_RESTART': '1', 19:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:47 INFO - 'PWD': '/builds/slave/test', 19:55:47 INFO - 'SHELL': '/bin/bash', 19:55:47 INFO - 'SHLVL': '1', 19:55:47 INFO - 'TERM': 'linux', 19:55:47 INFO - 'TMOUT': '86400', 19:55:47 INFO - 'USER': 'cltbld', 19:55:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:47 INFO - '_': '/tools/buildbot/bin/python'} 19:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:48 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 19:55:48 INFO - Cleaning up... 19:55:48 INFO - Return code: 0 19:55:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:55:48 INFO - Using env: {'DISPLAY': ':0', 19:55:48 INFO - 'HOME': '/home/cltbld', 19:55:48 INFO - 'LANG': 'en_US.UTF-8', 19:55:48 INFO - 'LANGUAGE': 'en_US:en', 19:55:48 INFO - 'LOGNAME': 'cltbld', 19:55:48 INFO - 'MAIL': '/var/mail/cltbld', 19:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:48 INFO - 'MOZ_NO_REMOTE': '1', 19:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:48 INFO - 'NO_EM_RESTART': '1', 19:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:48 INFO - 'PWD': '/builds/slave/test', 19:55:48 INFO - 'SHELL': '/bin/bash', 19:55:48 INFO - 'SHLVL': '1', 19:55:48 INFO - 'TERM': 'linux', 19:55:48 INFO - 'TMOUT': '86400', 19:55:48 INFO - 'USER': 'cltbld', 19:55:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:48 INFO - '_': '/tools/buildbot/bin/python'} 19:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:48 INFO - Downloading/unpacking psutil>=3.1.1 19:55:48 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 19:55:48 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 19:55:48 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 19:55:48 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 19:55:48 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 19:55:48 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 19:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:55:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:50 INFO - Installing collected packages: psutil 19:55:50 INFO - Running setup.py install for psutil 19:55:50 INFO - building 'psutil._psutil_linux' extension 19:55:50 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 19:55:50 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 19:55:50 INFO - building 'psutil._psutil_posix' extension 19:55:50 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 19:55:50 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 19:55:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:50 INFO - Successfully installed psutil 19:55:50 INFO - Cleaning up... 19:55:50 INFO - Return code: 0 19:55:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:55: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')]} 19:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55: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')]} 19:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:50 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 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:55:50 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 19:55:50 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 19:55:50 INFO - Using env: {'DISPLAY': ':0', 19:55:50 INFO - 'HOME': '/home/cltbld', 19:55:50 INFO - 'LANG': 'en_US.UTF-8', 19:55:50 INFO - 'LANGUAGE': 'en_US:en', 19:55:50 INFO - 'LOGNAME': 'cltbld', 19:55:50 INFO - 'MAIL': '/var/mail/cltbld', 19:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:50 INFO - 'MOZ_NO_REMOTE': '1', 19:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:50 INFO - 'NO_EM_RESTART': '1', 19:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:50 INFO - 'PWD': '/builds/slave/test', 19:55:50 INFO - 'SHELL': '/bin/bash', 19:55:50 INFO - 'SHLVL': '1', 19:55:50 INFO - 'TERM': 'linux', 19:55:50 INFO - 'TMOUT': '86400', 19:55:50 INFO - 'USER': 'cltbld', 19:55:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:50 INFO - '_': '/tools/buildbot/bin/python'} 19:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:55:51 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 19:55:51 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 19:55:51 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 19:55:51 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 19:55:51 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 19:55:51 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 19:55:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:55:52 INFO - Installing collected packages: mozsystemmonitor 19:55:52 INFO - Running setup.py install for mozsystemmonitor 19:55:53 INFO - Successfully installed mozsystemmonitor 19:55:53 INFO - Cleaning up... 19:55:53 INFO - Return code: 0 19:55:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:55: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')]} 19:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55: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')]} 19:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:53 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 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:55:53 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 19:55:53 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 19:55:53 INFO - Using env: {'DISPLAY': ':0', 19:55:53 INFO - 'HOME': '/home/cltbld', 19:55:53 INFO - 'LANG': 'en_US.UTF-8', 19:55:53 INFO - 'LANGUAGE': 'en_US:en', 19:55:53 INFO - 'LOGNAME': 'cltbld', 19:55:53 INFO - 'MAIL': '/var/mail/cltbld', 19:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:53 INFO - 'MOZ_NO_REMOTE': '1', 19:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:53 INFO - 'NO_EM_RESTART': '1', 19:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:53 INFO - 'PWD': '/builds/slave/test', 19:55:53 INFO - 'SHELL': '/bin/bash', 19:55:53 INFO - 'SHLVL': '1', 19:55:53 INFO - 'TERM': 'linux', 19:55:53 INFO - 'TMOUT': '86400', 19:55:53 INFO - 'USER': 'cltbld', 19:55:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:53 INFO - '_': '/tools/buildbot/bin/python'} 19:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:53 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 19:55:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:55:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:55:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 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 19:55:55 INFO - Downloading docopt-0.6.1.tar.gz 19:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:55:55 INFO - Installing collected packages: blobuploader, requests, docopt 19:55:55 INFO - Running setup.py install for blobuploader 19:55:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:55:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:55:56 INFO - Running setup.py install for requests 19:55:56 INFO - Running setup.py install for docopt 19:55:56 INFO - Successfully installed blobuploader requests docopt 19:55:56 INFO - Cleaning up... 19:55:56 INFO - Return code: 0 19:55:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:55: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')]} 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55: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')]} 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:56 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 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:55:56 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 19:55:56 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 19:55:56 INFO - Using env: {'DISPLAY': ':0', 19:55:56 INFO - 'HOME': '/home/cltbld', 19:55:56 INFO - 'LANG': 'en_US.UTF-8', 19:55:56 INFO - 'LANGUAGE': 'en_US:en', 19:55:56 INFO - 'LOGNAME': 'cltbld', 19:55:56 INFO - 'MAIL': '/var/mail/cltbld', 19:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:56 INFO - 'MOZ_NO_REMOTE': '1', 19:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:56 INFO - 'NO_EM_RESTART': '1', 19:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:56 INFO - 'PWD': '/builds/slave/test', 19:55:56 INFO - 'SHELL': '/bin/bash', 19:55:56 INFO - 'SHLVL': '1', 19:55:56 INFO - 'TERM': 'linux', 19:55:56 INFO - 'TMOUT': '86400', 19:55:56 INFO - 'USER': 'cltbld', 19:55:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:56 INFO - '_': '/tools/buildbot/bin/python'} 19:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:55:56 INFO - Running setup.py (path:/tmp/pip-wJRGzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:55:56 INFO - Running setup.py (path:/tmp/pip-aZyknE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:55:56 INFO - Running setup.py (path:/tmp/pip-O9R42t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:55:56 INFO - Running setup.py (path:/tmp/pip-qolDI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:55:57 INFO - Running setup.py (path:/tmp/pip-QY29_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:55:57 INFO - Running setup.py (path:/tmp/pip-E8aikp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:55:57 INFO - Running setup.py (path:/tmp/pip-zGZgjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:55:57 INFO - Running setup.py (path:/tmp/pip-TGG8eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:55:57 INFO - Running setup.py (path:/tmp/pip-FKT5RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:55:57 INFO - Running setup.py (path:/tmp/pip-kWAF0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:55:57 INFO - Running setup.py (path:/tmp/pip-HpcTvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:55:57 INFO - Running setup.py (path:/tmp/pip-CKQkwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:55:57 INFO - Running setup.py (path:/tmp/pip-NURoJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:55:57 INFO - Running setup.py (path:/tmp/pip-CFYLRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:57 INFO - Running setup.py (path:/tmp/pip-dlB4ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:55:57 INFO - Running setup.py (path:/tmp/pip-NnagrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:55:57 INFO - Running setup.py (path:/tmp/pip-Twoxmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:55:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:55:57 INFO - Running setup.py install for manifestparser 19:55:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Running setup.py install for mozcrash 19:55:58 INFO - Running setup.py install for mozdebug 19:55:58 INFO - Running setup.py install for mozdevice 19:55:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Running setup.py install for mozfile 19:55:58 INFO - Running setup.py install for mozhttpd 19:55:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Running setup.py install for mozinfo 19:55:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Running setup.py install for mozInstall 19:55:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Running setup.py install for mozleak 19:55:58 INFO - Running setup.py install for mozlog 19:55:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for moznetwork 19:55:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozprocess 19:55:59 INFO - Running setup.py install for mozprofile 19:55:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozrunner 19:55:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozscreenshot 19:55:59 INFO - Running setup.py install for moztest 19:55:59 INFO - Running setup.py install for mozversion 19:55:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:55:59 INFO - Cleaning up... 19:55:59 INFO - Return code: 0 19:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:59 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 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:55:59 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 19:55:59 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 19:55:59 INFO - Using env: {'DISPLAY': ':0', 19:55:59 INFO - 'HOME': '/home/cltbld', 19:55:59 INFO - 'LANG': 'en_US.UTF-8', 19:55:59 INFO - 'LANGUAGE': 'en_US:en', 19:55:59 INFO - 'LOGNAME': 'cltbld', 19:55:59 INFO - 'MAIL': '/var/mail/cltbld', 19:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:59 INFO - 'MOZ_NO_REMOTE': '1', 19:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:59 INFO - 'NO_EM_RESTART': '1', 19:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:59 INFO - 'PWD': '/builds/slave/test', 19:55:59 INFO - 'SHELL': '/bin/bash', 19:55:59 INFO - 'SHLVL': '1', 19:55:59 INFO - 'TERM': 'linux', 19:55:59 INFO - 'TMOUT': '86400', 19:55:59 INFO - 'USER': 'cltbld', 19:55:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:59 INFO - '_': '/tools/buildbot/bin/python'} 19:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:00 INFO - Running setup.py (path:/tmp/pip-4TsQ30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:00 INFO - Running setup.py (path:/tmp/pip-oEmZf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:00 INFO - Running setup.py (path:/tmp/pip-L9elaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:00 INFO - Running setup.py (path:/tmp/pip-j7kpM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:00 INFO - Running setup.py (path:/tmp/pip-r7B9Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:00 INFO - Running setup.py (path:/tmp/pip-s9TjkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:00 INFO - Running setup.py (path:/tmp/pip-PGVfgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:00 INFO - Running setup.py (path:/tmp/pip-uYReam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:00 INFO - Running setup.py (path:/tmp/pip-OOtikQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:00 INFO - Running setup.py (path:/tmp/pip-aU9kMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:00 INFO - Running setup.py (path:/tmp/pip-6Vxrfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:00 INFO - Running setup.py (path:/tmp/pip-u5XHAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:00 INFO - Running setup.py (path:/tmp/pip-usnOpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:00 INFO - Running setup.py (path:/tmp/pip-Oa54B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:01 INFO - Running setup.py (path:/tmp/pip-Uv9Zrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:01 INFO - Running setup.py (path:/tmp/pip-ThlJnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:01 INFO - Running setup.py (path:/tmp/pip-J5UUk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:01 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)) 19:56:01 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)) 19:56:01 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)) 19:56:01 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)) 19:56:01 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)) 19:56:01 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)) 19:56:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:03 INFO - Downloading blessings-1.6.tar.gz 19:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:03 INFO - Installing collected packages: blessings 19:56:03 INFO - Running setup.py install for blessings 19:56:03 INFO - Successfully installed blessings 19:56:03 INFO - Cleaning up... 19:56:03 INFO - Return code: 0 19:56:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:56:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:03 INFO - Reading from file tmpfile_stdout 19:56:03 INFO - Current package versions: 19:56:03 INFO - argparse == 1.2.1 19:56:03 INFO - blessings == 1.6 19:56:03 INFO - blobuploader == 1.2.4 19:56:03 INFO - docopt == 0.6.1 19:56:03 INFO - manifestparser == 1.1 19:56:03 INFO - mozInstall == 1.12 19:56:03 INFO - mozcrash == 0.17 19:56:03 INFO - mozdebug == 0.1 19:56:03 INFO - mozdevice == 0.48 19:56:03 INFO - mozfile == 1.2 19:56:03 INFO - mozhttpd == 0.7 19:56:03 INFO - mozinfo == 0.9 19:56:03 INFO - mozleak == 0.1 19:56:03 INFO - mozlog == 3.2 19:56:03 INFO - moznetwork == 0.27 19:56:03 INFO - mozprocess == 0.22 19:56:03 INFO - mozprofile == 0.28 19:56:03 INFO - mozrunner == 6.11 19:56:03 INFO - mozscreenshot == 0.1 19:56:03 INFO - mozsystemmonitor == 0.3 19:56:03 INFO - moztest == 0.7 19:56:03 INFO - mozversion == 1.4 19:56:03 INFO - psutil == 3.1.1 19:56:03 INFO - requests == 1.2.3 19:56:03 INFO - wsgiref == 0.1.2 19:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:03 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 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:56:03 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 19:56:03 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 19:56:03 INFO - Using env: {'DISPLAY': ':0', 19:56:03 INFO - 'HOME': '/home/cltbld', 19:56:03 INFO - 'LANG': 'en_US.UTF-8', 19:56:03 INFO - 'LANGUAGE': 'en_US:en', 19:56:03 INFO - 'LOGNAME': 'cltbld', 19:56:03 INFO - 'MAIL': '/var/mail/cltbld', 19:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:03 INFO - 'MOZ_NO_REMOTE': '1', 19:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:03 INFO - 'NO_EM_RESTART': '1', 19:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:03 INFO - 'PWD': '/builds/slave/test', 19:56:03 INFO - 'SHELL': '/bin/bash', 19:56:03 INFO - 'SHLVL': '1', 19:56:03 INFO - 'TERM': 'linux', 19:56:03 INFO - 'TMOUT': '86400', 19:56:03 INFO - 'USER': 'cltbld', 19:56:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:03 INFO - '_': '/tools/buildbot/bin/python'} 19:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 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)) 19:56:03 INFO - Cleaning up... 19:56:03 INFO - Return code: 0 19:56:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:56:03 INFO - Using env: {'DISPLAY': ':0', 19:56:03 INFO - 'HOME': '/home/cltbld', 19:56:03 INFO - 'LANG': 'en_US.UTF-8', 19:56:03 INFO - 'LANGUAGE': 'en_US:en', 19:56:03 INFO - 'LOGNAME': 'cltbld', 19:56:03 INFO - 'MAIL': '/var/mail/cltbld', 19:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:03 INFO - 'MOZ_NO_REMOTE': '1', 19:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:03 INFO - 'NO_EM_RESTART': '1', 19:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:03 INFO - 'PWD': '/builds/slave/test', 19:56:03 INFO - 'SHELL': '/bin/bash', 19:56:03 INFO - 'SHLVL': '1', 19:56:03 INFO - 'TERM': 'linux', 19:56:03 INFO - 'TMOUT': '86400', 19:56:03 INFO - 'USER': 'cltbld', 19:56:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:03 INFO - '_': '/tools/buildbot/bin/python'} 19:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:04 INFO - Downloading/unpacking jsonschema 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:06 INFO - Downloading/unpacking functools32 (from jsonschema) 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:06 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:06 INFO - warning: no files found matching '*.txt' 19:56:06 INFO - no previously-included directories found matching 'build' 19:56:06 INFO - no previously-included directories found matching 'dist' 19:56:06 INFO - no previously-included directories found matching '.git*' 19:56:06 INFO - Installing collected packages: jsonschema, functools32 19:56:06 INFO - Running setup.py install for functools32 19:56:06 INFO - warning: no files found matching '*.txt' 19:56:06 INFO - no previously-included directories found matching 'build' 19:56:06 INFO - no previously-included directories found matching 'dist' 19:56:06 INFO - no previously-included directories found matching '.git*' 19:56:06 INFO - Successfully installed jsonschema functools32 19:56:06 INFO - Cleaning up... 19:56:06 INFO - Return code: 0 19:56:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:56: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')]} 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf594b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', '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 19:56: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', 'flake8'] in /builds/slave/test/build 19:56: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 flake8 19:56:06 INFO - Using env: {'DISPLAY': ':0', 19:56:06 INFO - 'HOME': '/home/cltbld', 19:56:06 INFO - 'LANG': 'en_US.UTF-8', 19:56:06 INFO - 'LANGUAGE': 'en_US:en', 19:56:06 INFO - 'LOGNAME': 'cltbld', 19:56:06 INFO - 'MAIL': '/var/mail/cltbld', 19:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:06 INFO - 'MOZ_NO_REMOTE': '1', 19:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:06 INFO - 'NO_EM_RESTART': '1', 19:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:06 INFO - 'PWD': '/builds/slave/test', 19:56:06 INFO - 'SHELL': '/bin/bash', 19:56:06 INFO - 'SHLVL': '1', 19:56:06 INFO - 'TERM': 'linux', 19:56:06 INFO - 'TMOUT': '86400', 19:56:06 INFO - 'USER': 'cltbld', 19:56:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:06 INFO - '_': '/tools/buildbot/bin/python'} 19:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:06 INFO - Downloading/unpacking flake8 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:56:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:56:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:56:09 INFO - no previously-included directories found matching 'docs/_build' 19:56:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:56:09 INFO - Running setup.py install for pep8 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:56:09 INFO - no previously-included directories found matching 'docs/_build' 19:56:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:56:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:56:09 INFO - Cleaning up... 19:56:09 INFO - Return code: 0 19:56:09 INFO - Running post-action listener: _resource_record_post_action 19:56:09 INFO - Running post-action listener: _start_resource_monitoring 19:56:09 INFO - Starting resource monitoring. 19:56:09 INFO - ##### 19:56:09 INFO - ##### Finished create-virtualenv step (success) 19:56:09 INFO - ##### 19:56:09 INFO - ##### 19:56:09 INFO - ##### Running install step. 19:56:09 INFO - ##### 19:56:09 INFO - Running pre-action listener: _resource_record_pre_action 19:56:09 INFO - Running main action method: install 19:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:09 INFO - Reading from file tmpfile_stdout 19:56:09 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:56:09 INFO - Reading from file tmpfile_stdout 19:56:09 INFO - Output received: 19:56:09 INFO - Usage: mozinstall [options] installer 19:56:09 INFO - Options: 19:56:09 INFO - -h, --help show this help message and exit 19:56:09 INFO - -d DEST, --destination=DEST 19:56:09 INFO - Directory to install application into. [default: 19:56:09 INFO - "/builds/slave/test"] 19:56:09 INFO - --app=APP Application being installed. [default: firefox] 19:56:09 INFO - mkdir: /builds/slave/test/build/application 19:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:56:25 INFO - Reading from file tmpfile_stdout 19:56:25 INFO - Output received: 19:56:25 INFO - /builds/slave/test/build/application/firefox/firefox 19:56:25 INFO - Running post-action listener: _resource_record_post_action 19:56:25 INFO - ##### 19:56:25 INFO - ##### Finished install step (success) 19:56:25 INFO - ##### 19:56:25 INFO - ##### 19:56:25 INFO - ##### Running run-tests step. 19:56:25 INFO - ##### 19:56:25 INFO - Running pre-action listener: _resource_record_pre_action 19:56:25 INFO - Running main action method: run_tests 19:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:56:25 INFO - Python 2.7.3 19:56:25 INFO - Return code: 0 19:56:25 INFO - grabbing minidump binary from tooltool 19:56:25 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')]} 19:56:25 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 0x2cf89c0>, '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 0x2cf98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:56:25 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 19:56:25 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 19:56:25 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 19:56:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:56:25 INFO - Return code: 0 19:56:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:56:26 INFO - Return code: 0 19:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 19:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 19:56:26 INFO - Using env: {'DISPLAY': ':0', 19:56:26 INFO - 'HOME': '/home/cltbld', 19:56:26 INFO - 'LANG': 'en_US.UTF-8', 19:56:26 INFO - 'LANGUAGE': 'en_US:en', 19:56:26 INFO - 'LOGNAME': 'cltbld', 19:56:26 INFO - 'MAIL': '/var/mail/cltbld', 19:56:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:56:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:26 INFO - 'MOZ_NO_REMOTE': '1', 19:56:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:26 INFO - 'NO_EM_RESTART': '1', 19:56:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:26 INFO - 'PWD': '/builds/slave/test', 19:56:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:56:26 INFO - 'SHELL': '/bin/bash', 19:56:26 INFO - 'SHLVL': '1', 19:56:26 INFO - 'TERM': 'linux', 19:56:26 INFO - 'TMOUT': '86400', 19:56:26 INFO - 'USER': 'cltbld', 19:56:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949', 19:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:26 INFO - '_': '/tools/buildbot/bin/python'} 19:56:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 19:56:26 INFO - mozversion application_buildid: 20160519184305 19:56:26 INFO - mozversion application_changeset: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 19:56:26 INFO - mozversion application_display_name: Nightly 19:56:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:56:26 INFO - mozversion application_name: Firefox 19:56:26 INFO - mozversion application_remotingname: firefox 19:56:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:56:26 INFO - mozversion application_vendor: Mozilla 19:56:26 INFO - mozversion application_version: 49.0a1 19:56:26 INFO - mozversion platform_buildid: 20160519184305 19:56:26 INFO - mozversion platform_changeset: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 19:56:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:56:26 INFO - mozversion platform_version: 49.0a1 19:56:26 INFO - using testdate: 1463712986 19:56:26 INFO - actual date: 1463712986 19:56:26 INFO - starting webserver on 'localhost:48279' 19:56:26 INFO - SUITE-START | Running 2 tests 19:56:26 INFO - TEST-START | dromaeo_css 19:56:26 INFO - operating with platform_type : linux_ 19:56:26 INFO - Initialising browser for dromaeo_css test... 19:56:26 INFO - TEST-INFO | started process 6291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKRZjhe/profile http://localhost:48279/getInfo.html) 19:56:31 INFO - PROCESS | 6291 | __metrics Screen width/height:1600/1200 19:56:31 INFO - PROCESS | 6291 | colorDepth:24 19:56:31 INFO - PROCESS | 6291 | Browser inner width/height: 1024/697 19:56:31 INFO - PROCESS | 6291 | __metrics 19:56:32 ERROR - PROCESS | 6291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:56:33 INFO - TEST-INFO | 6291: exit 0 19:56:33 INFO - Browser initialized. 19:56:33 INFO - Running cycle 1/1 for dromaeo_css test... 19:56:33 INFO - TEST-INFO | started process 6371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKRZjhe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:45 INFO - PROCESS | 6371 | RSS: Main: 154497024 19:56:45 INFO - PROCESS | 6371 | 19:57:37 INFO - PROCESS | 6371 | 1463713057086 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] 19:59:48 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:48279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48279/tests/dromaeo/cssquery-ext.html) 19:59:49 INFO - PROCESS | 6371 | RSS: Main: 231862272 19:59:49 INFO - PROCESS | 6371 | 20:02:51 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:48279/tests/dromaeo/cssquery-ext.html (next: http://localhost:48279/tests/dromaeo/cssquery-jquery.html) 20:02:52 INFO - PROCESS | 6371 | RSS: Main: 236539904 20:02:52 INFO - PROCESS | 6371 | 20:05:54 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:48279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48279/tests/dromaeo/cssquery-mootools.html) 20:05:55 INFO - PROCESS | 6371 | RSS: Main: 243970048 20:05:55 INFO - PROCESS | 6371 | 20:08:57 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:48279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48279/tests/dromaeo/cssquery-prototype.html) 20:08:58 INFO - PROCESS | 6371 | RSS: Main: 237199360 20:08:58 INFO - PROCESS | 6371 | 20:12:00 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:48279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48279/tests/dromaeo/cssquery-yui.html) 20:12:01 INFO - PROCESS | 6371 | RSS: Main: 204779520 20:12:01 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:48279/tests/dromaeo/cssquery-yui.html (next: http://localhost:48279/tests/dromaeo/cssquery-dojo.html) 20:15:04 INFO - PROCESS | 6371 | RSS: Main: 269934592 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | __start_tp_report 20:15:04 INFO - PROCESS | 6371 | _x_x_mozilla_page_load 20:15:04 INFO - PROCESS | 6371 | _x_x_mozilla_page_load_details 20:15:04 INFO - PROCESS | 6371 | |i|pagename|runs| 20:15:04 INFO - PROCESS | 6371 | |0;dojo.html;2649.5363311420497;2674.411629441522;2679.9816069893445;2703.1349968010245;2716.0493827160485;4572.451305843303;4622.375979242801;4664.113818374506;4684.718916864987;4714;4617.030423611046;4660.860174194771;4666.113438446693;4675.906481870361;4679.859604211871;4225.154969006196;4343.6959412841115;4358.346248062784;4389.473263208403;4490.169318676039;4407.559244075599;4431.224535706238;4433.379326894237;4465.330200469939;4491.236489796726;4277.951901784052;4312.8490502832565;4326.502452218004;4353.84761533348;4360.847370342023;4300.161468513641;4303;4307.052448461365;4417.050334178167;4428.889277768049;4340.956590434087;4343.739375637472;4350.477942646871;4360.912781744348;4395.890102747425;4458.4426946631675;4512.819487220508;4553.112143132091;4591.701539399962;4637.976810115928;5062.063518249136;5095.439501654815;5106.64253502255;5112.284280200774;5117.053345131126;5080.644354895159;5102.948970510284;5139.331886854722;5140.922886156711;5141.76862041209;4633;4655.557722016403;4700.7179569225955;4714.693544919569;4775.044991001779;5129.538341549279;5146.176611742103;5159.484051594811;5208.114620514521;5210.166373380241;4969.3539839821315;4973.975130124326;5010.3737032870895;5021.924671129936;5026.095302845523;4907.1167189905445;4983.90032199354;5033.270175824485;5049.545540901337;5051.2423136529815;4978.054169707744;5031.345925029723;5031.77357018935;5041.873953151201;5079.873003174876;4917.139500587383;4972.353594032753;4986.276989836453;4991.975040124848;5033.0688822567945;4194.769287689206;4229.365595160751;4229.577042295746;4241.745495270294;4242.066745316026;3721.6092310307567;3735.458358538051;3736.7757934524016;3739.6447337502896;3769.8115094245177;4278.2085314216965;4353.976815448367;4390.956090439118;4394.714343567658;4431;4996.225585034325;5010.574101201439;5050.823221187315;5066.012127635149;5069.163588008011;4377.1683380157665;4381.671374646914;4386.122775444924;4394.934075988863;4417.204903117469;4443.955560444419;4446.510883802779;4482.641388688962;4489.977550112294;4582.266837306015;4688.2733176357715;4726.26742854858;4736.85789426304;4752.857414277577;4774.498677638868;5056.84829455117;5060.165072762953;5067.315912351785;5073.720945348041;5111.693298402108;4677.555632214934;4704.200285951328;4723.267893476516;4771.880702982453;4789.568938795386;4954.355933728736;4962.925556116734;4964.851054468371;4971.204607262821;4976.353074100344;5024.924626130538;5051.217061355495;5055.1406260936465;5060.114479965918;5095.694258344512;4833.854984350475;4841.709497430165;4887.657863949489;4904;4956;4887.1203183425905;4900.411950565955;4914.65597408178;4920.31115643803;4965.627577931597;4795.184818580919;4797.232442809134;4838.612910967185;4879.829205977774;4894.2658601210105;4847.200211964986;4885.8045678172475;4913.336699545515;4944.629152813625;4952.678075925053;4837.322774811459;4843.539863712942;4847.2729090636685;4849.345338379415;4889.119958407521 20:15:04 INFO - PROCESS | 6371 | |1;ext.html;565.8046778499422;569.6980600281847;573.4093883300197;582.2488989203927;594.5956749410402;29842.25394365139;30522;41566.58433415665;42308.78845605775;42402.57597424025;41560.37659435111;42016.57983420165;42030.57969420305;42039;42076.368854467204;7758.301752842243;7939.642716077761;7954.045514538235;7956.562389068599;7958.641861116234;7757.8060548486455;7880.921190788076;7898.447108702364;7902.683892644287;7908.920910790905;7878;7925.365970722357;7926.128125906146;7937.920620793776;7938.6427610757655;7839.098503672065;7897.289243968013;7906.44654874159;7912.406569507252;7919.841603167962;7799.181085986003;7833.608319584055;7874.251946065115;7880.842383152362;7882.132965373804;37911.81044094789;38211.42682859759;38291.61708382936;38306.616933830584;38378.616213837784;3001.774866884992;3179.7933134346194;3290.881557061637;3311.2549676322874;3317.717993970515;29216.561751573743;29250.268743281376;29261.707382926324;29586.852065739535;30273.243168920733;3458.6714262145056;3521.6478352164836;3523.3834079036064;3545.6808887200277;3629.2922880038404;266788;267393;267990;268350;268947;54347.45652543424;54507;54876.45123548713;54969.45030549723;55031.72484137554;40987.7950610245;56219;57303.14045289324;57454;57976.420235797945;11690.298582085103;11924.046076314047;11938.22401543897;11955.163138580216;11967.102467314986;9155.633774649074;9161.312901532412;9167.816643667089;9170.220531254918;9170.724878253663;11985.460654270579;15908.443204487787;16425.67148657044;16456.6708665826;16521.83478165227;5993.250843644544;6030.849228769228;6148.754049838046;6177.62934223948;6306.306306306303;805.3597390074905;895.7357579514058;897.9012308646044;1014.6955913226003;1037.1080870451406;28007.719922800512;28685.856570717013;28738.425231495254;28997.855010724812;29468.852655737013;938.4181807279394;952.9237660987104;976.9706908792748;1026.471367245869;1073.2272763610345;14883.255837208097;15283.923580382248;15329.552942116034;15340.539783806504;15375.692486150438;369982;371835;372118;374266;374276;48839.26741098886;50016.749916250184;50027.24959125616;50049.49950500448;50158.49841501611;1202.8105275693706;1211.5335595795682;1229.2194456520174;1240.8821161989597;1247.114548670436;27036.72963270342;27814.3046423841;28120.29699257535;28333.574996375482;28517.857410712815;43485.130297394506;43764;43830.12339753251;43838.56161438345;43858.12283754243;311676;319400;320859;321870;323222;31297.374052519277;32237.35525289528;37473.437898432094;37897.81051094727;39296.41055384229;42854.78572607117;42988.14023719571;43419.34870977001;43823.56176438195;44263;35081.298374032885;36950.81524592467;37696.43455348227;37940;38315;36853.815730922244;37111.628883710815;37184.69853555113;37353;37385.43921841229;35684.28631427409;36625.08437289089;36748.081297967765;37017.44473832948;37100.62899370972;33205.169870752456;33591.66408335885;34194;34308.65691343154;34450.655493445745;25501.744982549935;26217.73782262153;26626.7337326632;27582.44835103327;27740 20:15:04 INFO - PROCESS | 6371 | |2;jquery.html;372.2647770652961;372.3818461354152;376.3601876809423;382.269864558693;389.3167491053203;15725;17030.48908532743;17301.307947682093;17315.913420432913;17717.55706107348;15940.804439667014;16633.750493742602;16792.66414671706;16797.244124014418;17494.38769643063;4636.837710680127;4768.523147685239;4774.092922344761;4809.831655892044;4814.855554333376;3450.9309813803707;3620.3302389057976;5120.385553733558;5429;5432.891342173154;5484;5490.478404551581;5497.367802702701;5505.834824955257;5513.50378465938;5622.8313150605545;6045.546584006217;6058.212432383762;6059.697015149225;6062.969295219823;5189.325387699612;5263.605059697828;5331.173668081454;5340.759665815009;5374.973125134388;12685.556005539762;12769.297688627123;12822.80765788514;12892.290923999177;12947.093703440763;1866.8973206473638;1883.6797744383487;1898.1932678611536;1953.687410014391;1975.792541783121;9110.088991100836;9133.40632858862;9286.396384235004;9588.328816982814;9654.420734755868;1748.77265955425;1809.9004554749483;1832.9816701832945;1835.5686413692772;1852.2590963614527;69092.54935783989;71496.6425167876;72101.27898720998;73301.63349183273;73654.63172684156;9371.250299975985;9746.805063898682;10232.386056836465;10233.211604282593;10301.227407944434;14229.003969722227;14371.92814035923;14374.568762937128;14379.352929118215;14403.711925761427;6890.965545172242;6892.896606550906;7045.89431158533;7071.858562828715;7079.362857342864;6323.936760632335;6364.872702545923;6449;6464.967675161594;6474.9676251619385;4352.695311328177;4390.4511936008;4502.099580083996;4521.485302423659;4534.070515544306;1680.3614626441874;1711.7175666015216;1750.7723995880453;1813.7914139874083;1824.4239312180116;836.5858899844616;846.4075147396846;864.3128712673314;904.1997831918799;908.3232991421302;16200.432984845474;16438.260278287507;17199.22603482846;17233;17678.558036048944;829.0838623321264;846.5217152308926;860.1398601398602;883.9248663863515;939.1172298039821;9368.39105458143;9718.951405242928;9733.707988760349;9744.756381090388;9869.925029698661;376514;378964;382783;407255;413021;73290.26709732834;77632.22367776363;80319.59840200761;80567;80810.59594701989;875.7854325690247;889.6619284671783;907.9546022698838;915.9084091590788;917.4724533393326;15089.396424142911;15108.848911511184;15110.320035598645;15197.77203341973;15618.21908904573;34878.302433951685;35442.64557354394;35972.64027359798;36084.27831443409;36263.45604815877;50529.74735126448;50980.745096275765;51031.489685104156;51070.48929510806;51491.74254128705;7649.426293028157;7924.801879953047;7939.761807145795;7977.680892764224;8000.239977202156;8521.190486903733;11075.390853503135;11390.145739069438;11579.421028948687;11738.060955123741;10116.797664046531;10130.290879638354;10259;10323.535440905027;10361.378317300987;10164;10197;10253.84619230727;10336.896631033895;10378.169746420117;9915.30592858493;10169.491525423551;10366.792664146826;10529.105026072562;10672.89327106719;8007.399445041528;8107.554084525408;8126.471779334324;8130.227628375294;8275.55177843887;9047.909520904706;9445.811083778148;9635.277354198603;9676.70969870905;10146.594136234764 20:15:04 INFO - PROCESS | 6371 | |3;mootools.html;1267.2586536875926;1348.2651954684693;1434.6771976305333;1466.9633259168527;1646.7365221564544;6674.8998765018505;7603.505772124808;7792.688292468301;7808.882866757003;8010.799730006753;7539.849203015937;7727.497712648674;7728.806779830507;7733.381329493641;7733.458657893935;2224.855384400017;2254.842161048727;2264.1509433962265;2267.8979445924974;2269.3645779181857;2193.824494040481;2198.39544125366;2271.818254539633;2276.8178545716305;2277.1574517428576;2213.734351877769;2231.464448532349;2243.2821497120926;2250.133698526071;2252.0991603358707;2126.9042893069695;2134.3703607435846;2151.1610471915888;2151.4943988162768;2151.634222182225;2081.6044951459176;2082.37528741377;2089.0703636881594;2089.5089653931313;2090.1117025264202;7630.313271805564;7707.075150981862;7776.416768742367;7777;7789.649465773997;4475.261581838992;4681.88295292617;4681.9297710534365;4684.976575117136;4690.530946905282;2843.8151520151123;2891.826490410561;2898.9855050724614;2908.3165456117795;2972.1826497713087;863.4819108534891;876.2245412809646;894.0554294409633;898.7213963671282;902.7336935604012;10460;10486.370817750883;10487.846336902934;10566.154707623371;10567.73580660482;4124.484439445069;4161.83352665896;4247.745135291892;4251.553586873396;4315.5900189481945;8022.157673444204;8049.195080491904;8069.7175598853755;8139.877901831477;8144.592770361577;4551.0215303709865;4552.271636538138;4553.954460455419;4559.635229181657;4559.863204103882;3548.8935331940083;3979.9403008954887;4078.5105787305715;4114.691398145151;4190.979045104755;3430.27964127536;3440.1915549845767;3503.7197024238;3521.7182625389905;3526.20660351424;1012.9088382045651;1059.0944742245424;1069.8181309177457;1071.2715353559654;1076.8438576406377;849.9872501912353;872.9170728780756;886.096181894464;889.6708217959397;890.4523717913567;5438.401775804658;5530.751116199781;5572.442755724395;5628.352739435018;5815.89497995388;922.096345581334;926.3510950507972;961.4423634292094;972.8297547929084;979.0845559401982;3708.9814550927613;3752.587215406303;3763.7741735495956;3765.8305376258136;3772.1701225730844;9342.346035777431;9592.856107158399;9596.760080997892;9649;9660.565274562661;9023.729288121367;9420.717378478657;9576.664816731382;9589.90410095904;9590;7069.92930070703;7330.560166390141;7393.223711510322;7395.593242371721;7445.7766267012075;5288.127458969227;5386.245925570345;5403.5136837684795;5519.558435325244;5585.273914391103;8523.531205783742;8686.91313086861;8705.782355441164;8977.596008179517;9017;9035.50304733246;9079.137481939206;9138.17756401927;9149.542522873962;9155.496447695441;6069.2716873975405;6262.718177681924;6392.328805475544;6484.837879052872;6638.933610663831;7524.661390237343;7557.508761930457;7592.8861067082935;7603;7631.1605723371495;6597.571157874723;6621.503387246072;6718.8320291993095;6814.659267036529;6817.386435220854;6614.305497922649;6619.437347825488;6660.666966651551;6681.599104053772;6717.865642687021;5982.88034239304;6014.278286605635;6085.391460853879;6091.9086213707715;6095.116208149882;4676.8129274828625;4705.952940470552;4777.235642297216;4819.903601927872;4834.734089624963;4725.149473094876;4750.7862146202815;4765.928511072268;4808.8797780055775;4861.781219845045 20:15:04 INFO - PROCESS | 6371 | |4;prototype.html;285.4633289415898;286.10021482437736;295.11759838084134;297.42448362418736;300.8631072861848;4807.903841923159;4812.879678008052;4842.80628774849;4852.441969173546;4867.245576935572;4263.335415365396;4466.57567531084;4603.10239503297;4688.671792974493;4752.405949256343;3733.9253214935684;3740.1584643455276;3757.9060523486996;3758.1168425420005;3763.36022876111;3762.7742335459825;3772.2455508898192;3773.9622603774023;3779.848806047755;3780.262848744496;3611.5485564304463;3662.08447888028;3769.8492060317553;3770.7549009314307;3774.8867533974026;3764.9058773530605;3765.6610905018406;3770.2271034438013;3774.226283611853;3777.9055523611855;3376.59871153471;3383.4755612880044;3384.5938487381673;3390.135515443571;3402.795832250073;4542.795574199136;4559.635229181657;4575.679702420832;4601.631869450436;4606.124836281129;4296.37702533131;4304.4834619845815;4319.69762116652;4336;4341.630961368288;4950.18321976877;4974.701517908937;4983.526564976358;4986.5761410280165;5001.924586213945;3674.640383058259;3684.3052195989876;3688.243909998471;3695.7597756146033;3704.814759262026;4850.111944502991;4890;5021.774020169065;5137.255098010804;5140.691558506502;3756.567994680592;3759.5112635357227;3766.6798322142376;3771.6794072504144;3784.1863999240295;3841.2701586698995;3848.4034974578985;3850.517550742984;3854.3062248794927;3855.4409610606303;4268.417607347572;4313.223619748475;4315.115401342718;4321.481422229353;4335.1979883721615;4868.61051115917;4890.413150421972;4897.755112244374;4950;4952.737052051703;1297.8572357040719;1309.4892991733232;1311.4688551136805;1328.309279174843;1332.393760838816;845.3321875718236;873.2315562305131;877.7103555826562;879.8900137482815;881.7310720230391;3988.880333589997;3991.960080399159;3997.380406037069;4021.195760847842;4025.2352053109817;4563.338315944169;4575.444348921383;4596.069650746695;4602.516735742699;4617.607503362252;4022.1955608877756;4034.3141665916864;4040.939385909214;4077.26609210345;4080.8775736727944;2479.429731161843;2554.3358726731185;2759.379139693593;2762.737539933703;2767.5710264908566;4916.582090522345;4919.680220785637;4922.458529561745;4928.211486162269;4938.4320803107385;5225.817096401608;5243.449437809051;5267.183586544092;5305.495977882095;5339.652922560022;4577;4875.756212189376;4902.313676085422;4914.574773315699;4943.925841112458;5156.375741641371;5191.351081114861;5202;5206.843794686166;5224.791008359623;4892.339534162842;5123.487651234846;5125.2568377585785;5135.178371460698;5171.844844654666;4700.670953033392;4709.433358819383;4865.683730557503;4942.901141977069;4951.801927922843;3635.8365323096355;3639.4722765198367;3647.1976165243605;3647.744657873923;3680.5399325084363;5169.327987361619;5181.585473162213;5192.896142077213;5210.53105220532;5216.061109000417;4920.819003439077;5002.599792016557;5005.974970125126;5046.006827303121;5067.46791586878;4968.2795994579865;4990.451050384528;5008.524190201925;5012.77442515095;5023.598112150946;4881.560659540658;4895.485973972682;4899.730514821719;4914.812908255792;4933.235348520985;4772.832950846704;5034.489653104128;5040.395152581567;5061.924071138862;5085.38102877026;4936.580390666833;4936.950630493793;4955.4053513577155;4976.626752993468;4980.402351717817 20:15:04 INFO - PROCESS | 6371 | |5;yui.html;742.0983505041376;742.6917829100923;762.3977058124075;769.5075151902784;769.5690413368515;14274.357653905574;14527.636809079779;14556.636084097903;14557.854421455782;14559.708805823877;14122.858771412282;14211.857881421183;14239.216843073627;14240.074395164307;14261.35823887925;637.8788030274256;787.6258777080898;802.3460879383284;809.8420807942454;810.0198759501011;800.7797855589702;811.1563973467587;811.3509192645889;811.5414790643297;811.6631597886899;841.0202114536557;844.2317491083115;844.624142256696;851.1233429567525;851.2976794144824;649.3636236488221;814.3241109878786;832.2010869565255;832.8459235041506;839.9412041157121;623.6819222196667;624.3007831229007;624.3787431505635;624.9093881387173;625.0592857749104;12971.027172962065;13005.414756335987;13016.41426135826;13018.869811301955;13035.087543871932;11120.721981950435;11646.879484391171;11677.416129193507;11802.232854864405;12040.698982525419;10768.623098191525;10939.83590246147;10981.450927453676;11178.720531986684;11245.55017799287;3926.0773718176206;3941.4481972523868;3984.820683069269;4006.258842114218;4035.2131334389805;44158.33762493533;45993.31010034852;47020.82447938795;47070.5292947073;47282.29076563854;9583.616655333848;9655.420674759536;9669.17811985975;9705.417674939526;9843.409395436296;16655.583610409838;17087.829121708623;17094.572635684206;17095.743563846554;17106.315747370216;6758.42553382968;6815.182178138655;6865.691043903036;6911.7926462206215;6978.581285122909;3550.2544465661986;3642.21692336149;3664.6518580734787;3674.8346324415465;3695.1870588470492;2833.1217322629636;2925.8537073146686;2938.853057347124;2944.3522425066453;2944.5877577139217;513.8561202863204;524.8031988004499;527.0776141751934;529.4784637132421;533.0032838591858;448.6253977928401;586.9677167755729;593.3888095261888;598.7664810723821;600.8107446154447;8300.875486867702;8369.832603347899;8407.789805254795;8612.612432440555;8652.480851148825;579.6435192356755;595.2767387624058;598.5839841310247;598.6497898729206;609.9085137229451;3861.189150278417;3888.9411951259417;3954.723169378116;3980.44273801668;4007.899802504961;46344.7682761584;47941.28088078681;48140.518594814304;52030.21954670683;52726;47734.76132619384;47788.7610561945;47853.521464785605;48310.27534586984;50393.74803125961;45983.99999999933;46576.5342346579;46594;46949;47191.764041180264;7792;7809.843803123792;8339.54132522717;8405.95797021011;8508.106648802035;30722;30756.538651919793;31228.21929451691;31238.531422029144;31323.53014704827;39878.80363589097;40218.798906005286;40787.59212407838;41011.38482922699;41501.58498414977;10177.796444071226;10201.438920859424;10295.794084118126;10471.109955653856;10480.528376223241;11194.776104478027;11519.596814111466;11530.538778448768;11787.174897757075;11837.763244734884;11214.271072380268;11224.045956093823;11244.887551124384;11418.714532136431;11489.597864074718;10851.186161038111;11054.060404865677;11130.944345278222;11137.832932505857;11453.08375329955;11042.834357484484;11045.83431248548;11625.128115391548;11680.47437865281;11681.415929203677;9071.228945539702;9223.21602663781;9250.4912229828;9444.763880903032;9487.620495180392;9081.228095611947;9156.58795354224;9339.252859771337;9343;9526.571304291461 20:15:04 INFO - PROCESS | 6371 | __end_tp_report 20:15:04 INFO - PROCESS | 6371 | __start_cc_report 20:15:04 INFO - PROCESS | 6371 | _x_x_mozilla_cycle_collect,1045 20:15:04 INFO - PROCESS | 6371 | __end_cc_report 20:15:04 INFO - PROCESS | 6371 | __startTimestamp1463714104681__endTimestamp 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | ------- Summary: start ------- 20:15:04 INFO - PROCESS | 6371 | Number of tests: 6 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | [#0] dojo.html Cycles:165 Average:4658.28 Median:4774.50 stddev:480.77 (10.1%) stddev-sans-first:455.69 20:15:04 INFO - PROCESS | 6371 | Values: 2649.5 2674.4 2680.0 2703.1 2716.0 4572.5 4622.4 4664.1 4684.7 4714.0 4617.0 4660.9 4666.1 4675.9 4679.9 4225.2 4343.7 4358.3 4389.5 4490.2 4407.6 4431.2 4433.4 4465.3 4491.2 4278.0 4312.8 4326.5 4353.8 4360.8 4300.2 4303.0 4307.1 4417.1 4428.9 4341.0 4343.7 4350.5 4360.9 4395.9 4458.4 4512.8 4553.1 4591.7 4638.0 5062.1 5095.4 5106.6 5112.3 5117.1 5080.6 5102.9 5139.3 5140.9 5141.8 4633.0 4655.6 4700.7 4714.7 4775.0 5129.5 5146.2 5159.5 5208.1 5210.2 4969.4 4974.0 5010.4 5021.9 5026.1 4907.1 4983.9 5033.3 5049.5 5051.2 4978.1 5031.3 5031.8 5041.9 5079.9 4917.1 4972.4 4986.3 4992.0 5033.1 4194.8 4229.4 4229.6 4241.7 4242.1 3721.6 3735.5 3736.8 3739.6 3769.8 4278.2 4354.0 4391.0 4394.7 4431.0 4996.2 5010.6 5050.8 5066.0 5069.2 4377.2 4381.7 4386.1 4394.9 4417.2 4444.0 4446.5 4482.6 4490.0 4582.3 4688.3 4726.3 4736.9 4752.9 4774.5 5056.8 5060.2 5067.3 5073.7 5111.7 4677.6 4704.2 4723.3 4771.9 4789.6 4954.4 4962.9 4964.9 4971.2 4976.4 5024.9 5051.2 5055.1 5060.1 5095.7 4833.9 4841.7 4887.7 4904.0 4956.0 4887.1 4900.4 4914.7 4920.3 4965.6 4795.2 4797.2 4838.6 4879.8 4894.3 4847.2 4885.8 4913.3 4944.6 4952.7 4837.3 4843.5 4847.3 4849.3 4889.1 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | [#1] ext.html Cycles:180 Average:47902.54 Median:37584.94 stddev:84835.82 (225.7%) stddev-sans-first:84999.36 20:15:04 INFO - PROCESS | 6371 | Values: 565.8 569.7 573.4 582.2 594.6 29842.3 30522.0 41566.6 42308.8 42402.6 41560.4 42016.6 42030.6 42039.0 42076.4 7758.3 7939.6 7954.0 7956.6 7958.6 7757.8 7880.9 7898.4 7902.7 7908.9 7878.0 7925.4 7926.1 7937.9 7938.6 7839.1 7897.3 7906.4 7912.4 7919.8 7799.2 7833.6 7874.3 7880.8 7882.1 37911.8 38211.4 38291.6 38306.6 38378.6 3001.8 3179.8 3290.9 3311.3 3317.7 29216.6 29250.3 29261.7 29586.9 30273.2 3458.7 3521.6 3523.4 3545.7 3629.3 266788.0 267393.0 267990.0 268350.0 268947.0 54347.5 54507.0 54876.5 54969.5 55031.7 40987.8 56219.0 57303.1 57454.0 57976.4 11690.3 11924.0 11938.2 11955.2 11967.1 9155.6 9161.3 9167.8 9170.2 9170.7 11985.5 15908.4 16425.7 16456.7 16521.8 5993.3 6030.8 6148.8 6177.6 6306.3 805.4 895.7 897.9 1014.7 1037.1 28007.7 28685.9 28738.4 28997.9 29468.9 938.4 952.9 977.0 1026.5 1073.2 14883.3 15283.9 15329.6 15340.5 15375.7 369982.0 371835.0 372118.0 374266.0 374276.0 48839.3 50016.7 50027.2 50049.5 50158.5 1202.8 1211.5 1229.2 1240.9 1247.1 27036.7 27814.3 28120.3 28333.6 28517.9 43485.1 43764.0 43830.1 43838.6 43858.1 311676.0 319400.0 320859.0 321870.0 323222.0 31297.4 32237.4 37473.4 37897.8 39296.4 42854.8 42988.1 43419.3 43823.6 44263.0 35081.3 36950.8 37696.4 37940.0 38315.0 36853.8 37111.6 37184.7 37353.0 37385.4 35684.3 36625.1 36748.1 37017.4 37100.6 33205.2 33591.7 34194.0 34308.7 34450.7 25501.7 26217.7 26626.7 27582.4 27740.0 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | [#2] jquery.html Cycles:180 Average:24190.70 Median:4771.31 stddev:64835.79 (1358.9%) stddev-sans-first:64993.01 20:15:04 INFO - PROCESS | 6371 | Values: 372.3 372.4 376.4 382.3 389.3 15725.0 17030.5 17301.3 17315.9 17717.6 15940.8 16633.8 16792.7 16797.2 17494.4 4636.8 4768.5 4774.1 4809.8 4814.9 3450.9 3620.3 5120.4 5429.0 5432.9 5484.0 5490.5 5497.4 5505.8 5513.5 5622.8 6045.5 6058.2 6059.7 6063.0 5189.3 5263.6 5331.2 5340.8 5375.0 12685.6 12769.3 12822.8 12892.3 12947.1 1866.9 1883.7 1898.2 1953.7 1975.8 9110.1 9133.4 9286.4 9588.3 9654.4 1748.8 1809.9 1833.0 1835.6 1852.3 69092.5 71496.6 72101.3 73301.6 73654.6 9371.3 9746.8 10232.4 10233.2 10301.2 14229.0 14371.9 14374.6 14379.4 14403.7 6891.0 6892.9 7045.9 7071.9 7079.4 6323.9 6364.9 6449.0 6465.0 6475.0 4352.7 4390.5 4502.1 4521.5 4534.1 1680.4 1711.7 1750.8 1813.8 1824.4 836.6 846.4 864.3 904.2 908.3 16200.4 16438.3 17199.2 17233.0 17678.6 829.1 846.5 860.1 883.9 939.1 9368.4 9719.0 9733.7 9744.8 9869.9 376514.0 378964.0 382783.0 407255.0 413021.0 73290.3 77632.2 80319.6 80567.0 80810.6 875.8 889.7 908.0 915.9 917.5 15089.4 15108.8 15110.3 15197.8 15618.2 34878.3 35442.6 35972.6 36084.3 36263.5 50529.7 50980.7 51031.5 51070.5 51491.7 7649.4 7924.8 7939.8 7977.7 8000.2 8521.2 11075.4 11390.1 11579.4 11738.1 10116.8 10130.3 10259.0 10323.5 10361.4 10164.0 10197.0 10253.8 10336.9 10378.2 9915.3 10169.5 10366.8 10529.1 10672.9 8007.4 8107.6 8126.5 8130.2 8275.6 9047.9 9445.8 9635.3 9676.7 10146.6 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | [#3] mootools.html Cycles:180 Average:5097.47 Median:5551.60 stddev:2810.90 (50.6%) stddev-sans-first:2804.05 20:15:04 INFO - PROCESS | 6371 | Values: 1267.3 1348.3 1434.7 1467.0 1646.7 6674.9 7603.5 7792.7 7808.9 8010.8 7539.8 7727.5 7728.8 7733.4 7733.5 2224.9 2254.8 2264.2 2267.9 2269.4 2193.8 2198.4 2271.8 2276.8 2277.2 2213.7 2231.5 2243.3 2250.1 2252.1 2126.9 2134.4 2151.2 2151.5 2151.6 2081.6 2082.4 2089.1 2089.5 2090.1 7630.3 7707.1 7776.4 7777.0 7789.6 4475.3 4681.9 4681.9 4685.0 4690.5 2843.8 2891.8 2899.0 2908.3 2972.2 863.5 876.2 894.1 898.7 902.7 10460.0 10486.4 10487.8 10566.2 10567.7 4124.5 4161.8 4247.7 4251.6 4315.6 8022.2 8049.2 8069.7 8139.9 8144.6 4551.0 4552.3 4554.0 4559.6 4559.9 3548.9 3979.9 4078.5 4114.7 4191.0 3430.3 3440.2 3503.7 3521.7 3526.2 1012.9 1059.1 1069.8 1071.3 1076.8 850.0 872.9 886.1 889.7 890.5 5438.4 5530.8 5572.4 5628.4 5815.9 922.1 926.4 961.4 972.8 979.1 3709.0 3752.6 3763.8 3765.8 3772.2 9342.3 9592.9 9596.8 9649.0 9660.6 9023.7 9420.7 9576.7 9589.9 9590.0 7069.9 7330.6 7393.2 7395.6 7445.8 5288.1 5386.2 5403.5 5519.6 5585.3 8523.5 8686.9 8705.8 8977.6 9017.0 9035.5 9079.1 9138.2 9149.5 9155.5 6069.3 6262.7 6392.3 6484.8 6638.9 7524.7 7557.5 7592.9 7603.0 7631.2 6597.6 6621.5 6718.8 6814.7 6817.4 6614.3 6619.4 6660.7 6681.6 6717.9 5982.9 6014.3 6085.4 6091.9 6095.1 4676.8 4706.0 4777.2 4819.9 4834.7 4725.1 4750.8 4765.9 4808.9 4861.8 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | [#4] prototype.html Cycles:180 Average:4135.47 Median:4602.81 stddev:1185.18 (25.7%) stddev-sans-first:1152.74 20:15:04 INFO - PROCESS | 6371 | Values: 285.5 286.1 295.1 297.4 300.9 4807.9 4812.9 4842.8 4852.4 4867.2 4263.3 4466.6 4603.1 4688.7 4752.4 3733.9 3740.2 3757.9 3758.1 3763.4 3762.8 3772.2 3774.0 3779.8 3780.3 3611.5 3662.1 3769.8 3770.8 3774.9 3764.9 3765.7 3770.2 3774.2 3777.9 3376.6 3383.5 3384.6 3390.1 3402.8 4542.8 4559.6 4575.7 4601.6 4606.1 4296.4 4304.5 4319.7 4336.0 4341.6 4950.2 4974.7 4983.5 4986.6 5001.9 3674.6 3684.3 3688.2 3695.8 3704.8 4850.1 4890.0 5021.8 5137.3 5140.7 3756.6 3759.5 3766.7 3771.7 3784.2 3841.3 3848.4 3850.5 3854.3 3855.4 4268.4 4313.2 4315.1 4321.5 4335.2 4868.6 4890.4 4897.8 4950.0 4952.7 1297.9 1309.5 1311.5 1328.3 1332.4 845.3 873.2 877.7 879.9 881.7 3988.9 3992.0 3997.4 4021.2 4025.2 4563.3 4575.4 4596.1 4602.5 4617.6 4022.2 4034.3 4040.9 4077.3 4080.9 2479.4 2554.3 2759.4 2762.7 2767.6 4916.6 4919.7 4922.5 4928.2 4938.4 5225.8 5243.4 5267.2 5305.5 5339.7 4577.0 4875.8 4902.3 4914.6 4943.9 5156.4 5191.4 5202.0 5206.8 5224.8 4892.3 5123.5 5125.3 5135.2 5171.8 4700.7 4709.4 4865.7 4942.9 4951.8 3635.8 3639.5 3647.2 3647.7 3680.5 5169.3 5181.6 5192.9 5210.5 5216.1 4920.8 5002.6 5006.0 5046.0 5067.5 4968.3 4990.5 5008.5 5012.8 5023.6 4881.6 4895.5 4899.7 4914.8 4933.2 4772.8 5034.5 5040.4 5061.9 5085.4 4936.6 4937.0 4955.4 4976.6 4980.4 20:15:04 INFO - PROCESS | 6371 | 20:15:04 INFO - PROCESS | 6371 | [#5] yui.html Cycles:180 Average:13118.53 Median:46585.27 stddev:14763.98 (31.7%) stddev-sans-first:14776.14 20:15:04 INFO - PROCESS | 6371 | Values: 742.1 742.7 762.4 769.5 769.6 14274.4 14527.6 14556.6 14557.9 14559.7 14122.9 14211.9 14239.2 14240.1 14261.4 637.9 787.6 802.3 809.8 810.0 800.8 811.2 811.4 811.5 811.7 841.0 844.2 844.6 851.1 851.3 649.4 814.3 832.2 832.8 839.9 623.7 624.3 624.4 624.9 625.1 12971.0 13005.4 13016.4 13018.9 13035.1 11120.7 11646.9 11677.4 11802.2 12040.7 10768.6 10939.8 10981.5 11178.7 11245.6 3926.1 3941.4 3984.8 4006.3 4035.2 44158.3 45993.3 47020.8 47070.5 47282.3 9583.6 9655.4 9669.2 9705.4 9843.4 16655.6 17087.8 17094.6 17095.7 17106.3 6758.4 6815.2 6865.7 6911.8 6978.6 3550.3 3642.2 3664.7 3674.8 3695.2 2833.1 2925.9 2938.9 2944.4 2944.6 513.9 524.8 527.1 529.5 533.0 448.6 587.0 593.4 598.8 600.8 8300.9 8369.8 8407.8 8612.6 8652.5 579.6 595.3 598.6 598.6 609.9 3861.2 3888.9 3954.7 3980.4 4007.9 46344.8 47941.3 48140.5 52030.2 52726.0 47734.8 47788.8 47853.5 48310.3 50393.7 45984.0 46576.5 46594.0 46949.0 47191.8 7792.0 7809.8 8339.5 8406.0 8508.1 30722.0 30756.5 31228.2 31238.5 31323.5 39878.8 40218.8 40787.6 41011.4 41501.6 10177.8 10201.4 10295.8 10471.1 10480.5 11194.8 11519.6 11530.5 11787.2 11837.8 11214.3 11224.0 11244.9 11418.7 11489.6 10851.2 11054.1 11130.9 11137.8 11453.1 11042.8 11045.8 11625.1 11680.5 11681.4 9071.2 9223.2 9250.5 9444.8 9487.6 9081.2 9156.6 9339.3 9343.0 9526.6 20:15:04 INFO - PROCESS | 6371 | -------- Summary: end -------- 20:15:04 INFO - PROCESS | 6371 | 20:15:05 INFO - TEST-INFO | 6371: exit 0 20:15:05 INFO - TEST-OK | dromaeo_css | took 1118636ms 20:15:05 INFO - TEST-START | kraken 20:15:05 INFO - operating with platform_type : linux_ 20:15:05 INFO - Initialising browser for kraken test... 20:15:05 INFO - TEST-INFO | started process 6553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhEQJZ/profile http://localhost:48279/getInfo.html) 20:15:10 INFO - PROCESS | 6553 | __metrics Screen width/height:1600/1200 20:15:10 INFO - PROCESS | 6553 | colorDepth:24 20:15:10 INFO - PROCESS | 6553 | Browser inner width/height: 1024/697 20:15:10 INFO - PROCESS | 6553 | __metrics 20:15:11 ERROR - PROCESS | 6553 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:15:12 INFO - TEST-INFO | 6553: exit 0 20:15:12 INFO - Browser initialized. 20:15:12 INFO - Running cycle 1/1 for kraken test... 20:15:12 INFO - TEST-INFO | started process 6635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhEQJZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:24 INFO - PROCESS | 6635 | RSS: Main: 154537984 20:15:24 INFO - PROCESS | 6635 | 20:15:26 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48279/tests/kraken/driver.html?testName=audio-beat-detection) 20:15:27 INFO - PROCESS | 6635 | RSS: Main: 209928192 20:15:27 INFO - PROCESS | 6635 | 20:15:30 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48279/tests/kraken/driver.html?testName=audio-dft) 20:15:31 INFO - PROCESS | 6635 | RSS: Main: 198848512 20:15:31 INFO - PROCESS | 6635 | 20:15:34 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48279/tests/kraken/driver.html?testName=audio-fft) 20:15:35 INFO - PROCESS | 6635 | RSS: Main: 267595776 20:15:35 INFO - PROCESS | 6635 | 20:15:37 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48279/tests/kraken/driver.html?testName=audio-oscillator) 20:15:38 INFO - PROCESS | 6635 | RSS: Main: 176701440 20:15:38 INFO - PROCESS | 6635 | 20:15:40 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:15:41 INFO - PROCESS | 6635 | RSS: Main: 181530624 20:15:41 INFO - PROCESS | 6635 | 20:15:44 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48279/tests/kraken/driver.html?testName=imaging-darkroom) 20:15:45 INFO - PROCESS | 6635 | RSS: Main: 217001984 20:15:45 INFO - PROCESS | 6635 | 20:15:48 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48279/tests/kraken/driver.html?testName=imaging-desaturate) 20:15:49 INFO - PROCESS | 6635 | RSS: Main: 215445504 20:15:49 INFO - PROCESS | 6635 | 20:15:52 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48279/tests/kraken/driver.html?testName=json-parse-financial) 20:15:53 INFO - PROCESS | 6635 | RSS: Main: 216371200 20:15:53 INFO - PROCESS | 6635 | 20:15:54 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:15:55 INFO - PROCESS | 6635 | RSS: Main: 206229504 20:15:55 INFO - PROCESS | 6635 | 20:15:57 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:15:57 INFO - PROCESS | 6635 | RSS: Main: 207761408 20:15:57 INFO - PROCESS | 6635 | 20:16:00 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:01 INFO - PROCESS | 6635 | RSS: Main: 219586560 20:16:01 INFO - PROCESS | 6635 | 20:16:03 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:04 INFO - PROCESS | 6635 | RSS: Main: 222445568 20:16:04 INFO - PROCESS | 6635 | 20:16:07 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:08 INFO - PROCESS | 6635 | RSS: Main: 222203904 20:16:08 INFO - PROCESS | 6635 | 20:16:09 INFO - PROCESS | 6635 | Cycle 1(1): loaded http://localhost:48279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48279/tests/kraken/driver.html?testName=ai-astar) 20:16:10 INFO - PROCESS | 6635 | RSS: Main: 269119488 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | __start_tp_report 20:16:10 INFO - PROCESS | 6635 | _x_x_mozilla_page_load 20:16:10 INFO - PROCESS | 6635 | _x_x_mozilla_page_load_details 20:16:10 INFO - PROCESS | 6635 | |i|pagename|runs| 20:16:10 INFO - PROCESS | 6635 | |0;ai-astar;114;109;116;117;117;114;116;114;114;113 20:16:10 INFO - PROCESS | 6635 | |1;audio-beat-detection;156;129;149;219;135;166;161;130;195;131 20:16:10 INFO - PROCESS | 6635 | |2;audio-dft;161;160;160;161;159;159;162;159;160;161 20:16:10 INFO - PROCESS | 6635 | |3;audio-fft;76;75;76;147;76;77;76;75;132;76 20:16:10 INFO - PROCESS | 6635 | |4;audio-oscillator;93;95;155;93;94;94;123;94;94;116 20:16:10 INFO - PROCESS | 6635 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 20:16:10 INFO - PROCESS | 6635 | |6;imaging-darkroom;146;146;146;147;146;146;147;146;146;145 20:16:10 INFO - PROCESS | 6635 | |7;imaging-desaturate;95;95;95;94;95;95;96;95;94;94 20:16:10 INFO - PROCESS | 6635 | |8;json-parse-financial;63;63;64;64;64;64;64;115;61;61 20:16:10 INFO - PROCESS | 6635 | |9;json-stringify-tinderbox;66;65;66;66;66;65;66;64;66;65 20:16:10 INFO - PROCESS | 6635 | |10;stanford-crypto-aes;85;83;89;83;83;84;88;85;85;86 20:16:10 INFO - PROCESS | 6635 | |11;stanford-crypto-ccm;141;130;141;144;135;127;128;137;264;146 20:16:10 INFO - PROCESS | 6635 | |12;stanford-crypto-pbkdf2;182;174;175;175;172;174;172;172;176;171 20:16:10 INFO - PROCESS | 6635 | |13;stanford-crypto-sha256-iterative;67;67;66;67;66;66;66;65;65;65 20:16:10 INFO - PROCESS | 6635 | __end_tp_report 20:16:10 INFO - PROCESS | 6635 | __start_cc_report 20:16:10 INFO - PROCESS | 6635 | _x_x_mozilla_cycle_collect,2096 20:16:10 INFO - PROCESS | 6635 | __end_cc_report 20:16:10 INFO - PROCESS | 6635 | __startTimestamp1463714170246__endTimestamp 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | ------- Summary: start ------- 20:16:10 INFO - PROCESS | 6635 | Number of tests: 14 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.37 (2.1%) stddev-sans-first:2.51 20:16:10 INFO - PROCESS | 6635 | Values: 114.0 109.0 116.0 117.0 117.0 114.0 116.0 114.0 114.0 113.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:158.50 stddev:30.04 (19.0%) stddev-sans-first:31.86 20:16:10 INFO - PROCESS | 6635 | Values: 156.0 129.0 149.0 219.0 135.0 166.0 161.0 130.0 195.0 131.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 20:16:10 INFO - PROCESS | 6635 | Values: 161.0 160.0 160.0 161.0 159.0 159.0 162.0 159.0 160.0 161.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#3] audio-fft Cycles:10 Average:88.60 Median:76.00 stddev:27.06 (35.6%) stddev-sans-first:28.32 20:16:10 INFO - PROCESS | 6635 | Values: 76.0 75.0 76.0 147.0 76.0 77.0 76.0 75.0 132.0 76.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:94.00 stddev:20.59 (21.9%) stddev-sans-first:21.37 20:16:10 INFO - PROCESS | 6635 | Values: 93.0 95.0 155.0 93.0 94.0 94.0 123.0 94.0 94.0 116.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:16:10 INFO - PROCESS | 6635 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 20:16:10 INFO - PROCESS | 6635 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 145.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:16:10 INFO - PROCESS | 6635 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 94.0 94.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:64.00 stddev:16.45 (25.7%) stddev-sans-first:17.34 20:16:10 INFO - PROCESS | 6635 | Values: 63.0 63.0 64.0 64.0 64.0 64.0 64.0 115.0 61.0 61.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 20:16:10 INFO - PROCESS | 6635 | Values: 66.0 65.0 66.0 66.0 66.0 65.0 66.0 64.0 66.0 65.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.08 (2.4%) stddev-sans-first:2.20 20:16:10 INFO - PROCESS | 6635 | Values: 85.0 83.0 89.0 83.0 83.0 84.0 88.0 85.0 85.0 86.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:141.00 stddev:40.84 (29.0%) stddev-sans-first:43.21 20:16:10 INFO - PROCESS | 6635 | Values: 141.0 130.0 141.0 144.0 135.0 127.0 128.0 137.0 264.0 146.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.50 stddev:3.16 (1.8%) stddev-sans-first:1.74 20:16:10 INFO - PROCESS | 6635 | Values: 182.0 174.0 175.0 175.0 172.0 174.0 172.0 172.0 176.0 171.0 20:16:10 INFO - PROCESS | 6635 | 20:16:10 INFO - PROCESS | 6635 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 20:16:10 INFO - PROCESS | 6635 | Values: 67.0 67.0 66.0 67.0 66.0 66.0 66.0 65.0 65.0 65.0 20:16:10 INFO - PROCESS | 6635 | -------- Summary: end -------- 20:16:10 INFO - PROCESS | 6635 | 20:16:11 INFO - TEST-INFO | 6635: exit 0 20:16:11 INFO - TEST-OK | kraken | took 65852ms 20:16:11 INFO - SUITE-END | took 1184s 20:16:11 INFO - Completed test suite (00:19:44) 20:16:11 INFO - javascript benchmark 20:16:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.5363311420497, 2674.411629441522, 2679.9816069893445, 2703.1349968010245, 2716.0493827160485, 4572.451305843303, 4622.375979242801, 4664.113818374506, 4684.718916864987, 4714.0, 4617.030423611046, 4660.860174194771, 4666.113438446693, 4675.906481870361, 4679.859604211871, 4225.154969006196, 4343.6959412841115, 4358.346248062784, 4389.473263208403, 4490.169318676039, 4407.559244075599, 4431.224535706238, 4433.379326894237, 4465.330200469939, 4491.236489796726, 4277.951901784052, 4312.8490502832565, 4326.502452218004, 4353.84761533348, 4360.847370342023, 4300.161468513641, 4303.0, 4307.052448461365, 4417.050334178167, 4428.889277768049, 4340.956590434087, 4343.739375637472, 4350.477942646871, 4360.912781744348, 4395.890102747425, 4458.4426946631675, 4512.819487220508, 4553.112143132091, 4591.701539399962, 4637.976810115928, 5062.063518249136, 5095.439501654815, 5106.64253502255, 5112.284280200774, 5117.053345131126, 5080.644354895159, 5102.948970510284, 5139.331886854722, 5140.922886156711, 5141.76862041209, 4633.0, 4655.557722016403, 4700.7179569225955, 4714.693544919569, 4775.044991001779, 5129.538341549279, 5146.176611742103, 5159.484051594811, 5208.114620514521, 5210.166373380241, 4969.3539839821315, 4973.975130124326, 5010.3737032870895, 5021.924671129936, 5026.095302845523, 4907.1167189905445, 4983.90032199354, 5033.270175824485, 5049.545540901337, 5051.2423136529815, 4978.054169707744, 5031.345925029723, 5031.77357018935, 5041.873953151201, 5079.873003174876, 4917.139500587383, 4972.353594032753, 4986.276989836453, 4991.975040124848, 5033.0688822567945, 4194.769287689206, 4229.365595160751, 4229.577042295746, 4241.745495270294, 4242.066745316026, 3721.6092310307567, 3735.458358538051, 3736.7757934524016, 3739.6447337502896, 3769.8115094245177, 4278.2085314216965, 4353.976815448367, 4390.956090439118, 4394.714343567658, 4431.0, 4996.225585034325, 5010.574101201439, 5050.823221187315, 5066.012127635149, 5069.163588008011, 4377.1683380157665, 4381.671374646914, 4386.122775444924, 4394.934075988863, 4417.204903117469, 4443.955560444419, 4446.510883802779, 4482.641388688962, 4489.977550112294, 4582.266837306015, 4688.2733176357715, 4726.26742854858, 4736.85789426304, 4752.857414277577, 4774.498677638868, 5056.84829455117, 5060.165072762953, 5067.315912351785, 5073.720945348041, 5111.693298402108, 4677.555632214934, 4704.200285951328, 4723.267893476516, 4771.880702982453, 4789.568938795386, 4954.355933728736, 4962.925556116734, 4964.851054468371, 4971.204607262821, 4976.353074100344, 5024.924626130538, 5051.217061355495, 5055.1406260936465, 5060.114479965918, 5095.694258344512, 4833.854984350475, 4841.709497430165, 4887.657863949489, 4904.0, 4956.0, 4887.1203183425905, 4900.411950565955, 4914.65597408178, 4920.31115643803, 4965.627577931597, 4795.184818580919, 4797.232442809134, 4838.612910967185, 4879.829205977774, 4894.2658601210105, 4847.200211964986, 4885.8045678172475, 4913.336699545515, 4944.629152813625, 4952.678075925053, 4837.322774811459, 4843.539863712942, 4847.2729090636685, 4849.345338379415, 4889.119958407521], "value": 4628.346048200175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.8046778499422, 569.6980600281847, 573.4093883300197, 582.2488989203927, 594.5956749410402, 29842.25394365139, 30522.0, 41566.58433415665, 42308.78845605775, 42402.57597424025, 41560.37659435111, 42016.57983420165, 42030.57969420305, 42039.0, 42076.368854467204, 7758.301752842243, 7939.642716077761, 7954.045514538235, 7956.562389068599, 7958.641861116234, 7757.8060548486455, 7880.921190788076, 7898.447108702364, 7902.683892644287, 7908.920910790905, 7878.0, 7925.365970722357, 7926.128125906146, 7937.920620793776, 7938.6427610757655, 7839.098503672065, 7897.289243968013, 7906.44654874159, 7912.406569507252, 7919.841603167962, 7799.181085986003, 7833.608319584055, 7874.251946065115, 7880.842383152362, 7882.132965373804, 37911.81044094789, 38211.42682859759, 38291.61708382936, 38306.616933830584, 38378.616213837784, 3001.774866884992, 3179.7933134346194, 3290.881557061637, 3311.2549676322874, 3317.717993970515, 29216.561751573743, 29250.268743281376, 29261.707382926324, 29586.852065739535, 30273.243168920733, 3458.6714262145056, 3521.6478352164836, 3523.3834079036064, 3545.6808887200277, 3629.2922880038404, 266788.0, 267393.0, 267990.0, 268350.0, 268947.0, 54347.45652543424, 54507.0, 54876.45123548713, 54969.45030549723, 55031.72484137554, 40987.7950610245, 56219.0, 57303.14045289324, 57454.0, 57976.420235797945, 11690.298582085103, 11924.046076314047, 11938.22401543897, 11955.163138580216, 11967.102467314986, 9155.633774649074, 9161.312901532412, 9167.816643667089, 9170.220531254918, 9170.724878253663, 11985.460654270579, 15908.443204487787, 16425.67148657044, 16456.6708665826, 16521.83478165227, 5993.250843644544, 6030.849228769228, 6148.754049838046, 6177.62934223948, 6306.306306306303, 805.3597390074905, 895.7357579514058, 897.9012308646044, 1014.6955913226003, 1037.1080870451406, 28007.719922800512, 28685.856570717013, 28738.425231495254, 28997.855010724812, 29468.852655737013, 938.4181807279394, 952.9237660987104, 976.9706908792748, 1026.471367245869, 1073.2272763610345, 14883.255837208097, 15283.923580382248, 15329.552942116034, 15340.539783806504, 15375.692486150438, 369982.0, 371835.0, 372118.0, 374266.0, 374276.0, 48839.26741098886, 50016.749916250184, 50027.24959125616, 50049.49950500448, 50158.49841501611, 1202.8105275693706, 1211.5335595795682, 1229.2194456520174, 1240.8821161989597, 1247.114548670436, 27036.72963270342, 27814.3046423841, 28120.29699257535, 28333.574996375482, 28517.857410712815, 43485.130297394506, 43764.0, 43830.12339753251, 43838.56161438345, 43858.12283754243, 311676.0, 319400.0, 320859.0, 321870.0, 323222.0, 31297.374052519277, 32237.35525289528, 37473.437898432094, 37897.81051094727, 39296.41055384229, 42854.78572607117, 42988.14023719571, 43419.34870977001, 43823.56176438195, 44263.0, 35081.298374032885, 36950.81524592467, 37696.43455348227, 37940.0, 38315.0, 36853.815730922244, 37111.628883710815, 37184.69853555113, 37353.0, 37385.43921841229, 35684.28631427409, 36625.08437289089, 36748.081297967765, 37017.44473832948, 37100.62899370972, 33205.169870752456, 33591.66408335885, 34194.0, 34308.65691343154, 34450.655493445745, 25501.744982549935, 26217.73782262153, 26626.7337326632, 27582.44835103327, 27740.0], "value": 17641.16514712595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.2647770652961, 372.3818461354152, 376.3601876809423, 382.269864558693, 389.3167491053203, 15725.0, 17030.48908532743, 17301.307947682093, 17315.913420432913, 17717.55706107348, 15940.804439667014, 16633.750493742602, 16792.66414671706, 16797.244124014418, 17494.38769643063, 4636.837710680127, 4768.523147685239, 4774.092922344761, 4809.831655892044, 4814.855554333376, 3450.9309813803707, 3620.3302389057976, 5120.385553733558, 5429.0, 5432.891342173154, 5484.0, 5490.478404551581, 5497.367802702701, 5505.834824955257, 5513.50378465938, 5622.8313150605545, 6045.546584006217, 6058.212432383762, 6059.697015149225, 6062.969295219823, 5189.325387699612, 5263.605059697828, 5331.173668081454, 5340.759665815009, 5374.973125134388, 12685.556005539762, 12769.297688627123, 12822.80765788514, 12892.290923999177, 12947.093703440763, 1866.8973206473638, 1883.6797744383487, 1898.1932678611536, 1953.687410014391, 1975.792541783121, 9110.088991100836, 9133.40632858862, 9286.396384235004, 9588.328816982814, 9654.420734755868, 1748.77265955425, 1809.9004554749483, 1832.9816701832945, 1835.5686413692772, 1852.2590963614527, 69092.54935783989, 71496.6425167876, 72101.27898720998, 73301.63349183273, 73654.63172684156, 9371.250299975985, 9746.805063898682, 10232.386056836465, 10233.211604282593, 10301.227407944434, 14229.003969722227, 14371.92814035923, 14374.568762937128, 14379.352929118215, 14403.711925761427, 6890.965545172242, 6892.896606550906, 7045.89431158533, 7071.858562828715, 7079.362857342864, 6323.936760632335, 6364.872702545923, 6449.0, 6464.967675161594, 6474.9676251619385, 4352.695311328177, 4390.4511936008, 4502.099580083996, 4521.485302423659, 4534.070515544306, 1680.3614626441874, 1711.7175666015216, 1750.7723995880453, 1813.7914139874083, 1824.4239312180116, 836.5858899844616, 846.4075147396846, 864.3128712673314, 904.1997831918799, 908.3232991421302, 16200.432984845474, 16438.260278287507, 17199.22603482846, 17233.0, 17678.558036048944, 829.0838623321264, 846.5217152308926, 860.1398601398602, 883.9248663863515, 939.1172298039821, 9368.39105458143, 9718.951405242928, 9733.707988760349, 9744.756381090388, 9869.925029698661, 376514.0, 378964.0, 382783.0, 407255.0, 413021.0, 73290.26709732834, 77632.22367776363, 80319.59840200761, 80567.0, 80810.59594701989, 875.7854325690247, 889.6619284671783, 907.9546022698838, 915.9084091590788, 917.4724533393326, 15089.396424142911, 15108.848911511184, 15110.320035598645, 15197.77203341973, 15618.21908904573, 34878.302433951685, 35442.64557354394, 35972.64027359798, 36084.27831443409, 36263.45604815877, 50529.74735126448, 50980.745096275765, 51031.489685104156, 51070.48929510806, 51491.74254128705, 7649.426293028157, 7924.801879953047, 7939.761807145795, 7977.680892764224, 8000.239977202156, 8521.190486903733, 11075.390853503135, 11390.145739069438, 11579.421028948687, 11738.060955123741, 10116.797664046531, 10130.290879638354, 10259.0, 10323.535440905027, 10361.378317300987, 10164.0, 10197.0, 10253.84619230727, 10336.896631033895, 10378.169746420117, 9915.30592858493, 10169.491525423551, 10366.792664146826, 10529.105026072562, 10672.89327106719, 8007.399445041528, 8107.554084525408, 8126.471779334324, 8130.227628375294, 8275.55177843887, 9047.909520904706, 9445.811083778148, 9635.277354198603, 9676.70969870905, 10146.594136234764], "value": 8066.108382933263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.2586536875926, 1348.2651954684693, 1434.6771976305333, 1466.9633259168527, 1646.7365221564544, 6674.8998765018505, 7603.505772124808, 7792.688292468301, 7808.882866757003, 8010.799730006753, 7539.849203015937, 7727.497712648674, 7728.806779830507, 7733.381329493641, 7733.458657893935, 2224.855384400017, 2254.842161048727, 2264.1509433962265, 2267.8979445924974, 2269.3645779181857, 2193.824494040481, 2198.39544125366, 2271.818254539633, 2276.8178545716305, 2277.1574517428576, 2213.734351877769, 2231.464448532349, 2243.2821497120926, 2250.133698526071, 2252.0991603358707, 2126.9042893069695, 2134.3703607435846, 2151.1610471915888, 2151.4943988162768, 2151.634222182225, 2081.6044951459176, 2082.37528741377, 2089.0703636881594, 2089.5089653931313, 2090.1117025264202, 7630.313271805564, 7707.075150981862, 7776.416768742367, 7777.0, 7789.649465773997, 4475.261581838992, 4681.88295292617, 4681.9297710534365, 4684.976575117136, 4690.530946905282, 2843.8151520151123, 2891.826490410561, 2898.9855050724614, 2908.3165456117795, 2972.1826497713087, 863.4819108534891, 876.2245412809646, 894.0554294409633, 898.7213963671282, 902.7336935604012, 10460.0, 10486.370817750883, 10487.846336902934, 10566.154707623371, 10567.73580660482, 4124.484439445069, 4161.83352665896, 4247.745135291892, 4251.553586873396, 4315.5900189481945, 8022.157673444204, 8049.195080491904, 8069.7175598853755, 8139.877901831477, 8144.592770361577, 4551.0215303709865, 4552.271636538138, 4553.954460455419, 4559.635229181657, 4559.863204103882, 3548.8935331940083, 3979.9403008954887, 4078.5105787305715, 4114.691398145151, 4190.979045104755, 3430.27964127536, 3440.1915549845767, 3503.7197024238, 3521.7182625389905, 3526.20660351424, 1012.9088382045651, 1059.0944742245424, 1069.8181309177457, 1071.2715353559654, 1076.8438576406377, 849.9872501912353, 872.9170728780756, 886.096181894464, 889.6708217959397, 890.4523717913567, 5438.401775804658, 5530.751116199781, 5572.442755724395, 5628.352739435018, 5815.89497995388, 922.096345581334, 926.3510950507972, 961.4423634292094, 972.8297547929084, 979.0845559401982, 3708.9814550927613, 3752.587215406303, 3763.7741735495956, 3765.8305376258136, 3772.1701225730844, 9342.346035777431, 9592.856107158399, 9596.760080997892, 9649.0, 9660.565274562661, 9023.729288121367, 9420.717378478657, 9576.664816731382, 9589.90410095904, 9590.0, 7069.92930070703, 7330.560166390141, 7393.223711510322, 7395.593242371721, 7445.7766267012075, 5288.127458969227, 5386.245925570345, 5403.5136837684795, 5519.558435325244, 5585.273914391103, 8523.531205783742, 8686.91313086861, 8705.782355441164, 8977.596008179517, 9017.0, 9035.50304733246, 9079.137481939206, 9138.17756401927, 9149.542522873962, 9155.496447695441, 6069.2716873975405, 6262.718177681924, 6392.328805475544, 6484.837879052872, 6638.933610663831, 7524.661390237343, 7557.508761930457, 7592.8861067082935, 7603.0, 7631.1605723371495, 6597.571157874723, 6621.503387246072, 6718.8320291993095, 6814.659267036529, 6817.386435220854, 6614.305497922649, 6619.437347825488, 6660.666966651551, 6681.599104053772, 6717.865642687021, 5982.88034239304, 6014.278286605635, 6085.391460853879, 6091.9086213707715, 6095.116208149882, 4676.8129274828625, 4705.952940470552, 4777.235642297216, 4819.903601927872, 4834.734089624963, 4725.149473094876, 4750.7862146202815, 4765.928511072268, 4808.8797780055775, 4861.781219845045], "value": 4124.0383375654965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.4633289415898, 286.10021482437736, 295.11759838084134, 297.42448362418736, 300.8631072861848, 4807.903841923159, 4812.879678008052, 4842.80628774849, 4852.441969173546, 4867.245576935572, 4263.335415365396, 4466.57567531084, 4603.10239503297, 4688.671792974493, 4752.405949256343, 3733.9253214935684, 3740.1584643455276, 3757.9060523486996, 3758.1168425420005, 3763.36022876111, 3762.7742335459825, 3772.2455508898192, 3773.9622603774023, 3779.848806047755, 3780.262848744496, 3611.5485564304463, 3662.08447888028, 3769.8492060317553, 3770.7549009314307, 3774.8867533974026, 3764.9058773530605, 3765.6610905018406, 3770.2271034438013, 3774.226283611853, 3777.9055523611855, 3376.59871153471, 3383.4755612880044, 3384.5938487381673, 3390.135515443571, 3402.795832250073, 4542.795574199136, 4559.635229181657, 4575.679702420832, 4601.631869450436, 4606.124836281129, 4296.37702533131, 4304.4834619845815, 4319.69762116652, 4336.0, 4341.630961368288, 4950.18321976877, 4974.701517908937, 4983.526564976358, 4986.5761410280165, 5001.924586213945, 3674.640383058259, 3684.3052195989876, 3688.243909998471, 3695.7597756146033, 3704.814759262026, 4850.111944502991, 4890.0, 5021.774020169065, 5137.255098010804, 5140.691558506502, 3756.567994680592, 3759.5112635357227, 3766.6798322142376, 3771.6794072504144, 3784.1863999240295, 3841.2701586698995, 3848.4034974578985, 3850.517550742984, 3854.3062248794927, 3855.4409610606303, 4268.417607347572, 4313.223619748475, 4315.115401342718, 4321.481422229353, 4335.1979883721615, 4868.61051115917, 4890.413150421972, 4897.755112244374, 4950.0, 4952.737052051703, 1297.8572357040719, 1309.4892991733232, 1311.4688551136805, 1328.309279174843, 1332.393760838816, 845.3321875718236, 873.2315562305131, 877.7103555826562, 879.8900137482815, 881.7310720230391, 3988.880333589997, 3991.960080399159, 3997.380406037069, 4021.195760847842, 4025.2352053109817, 4563.338315944169, 4575.444348921383, 4596.069650746695, 4602.516735742699, 4617.607503362252, 4022.1955608877756, 4034.3141665916864, 4040.939385909214, 4077.26609210345, 4080.8775736727944, 2479.429731161843, 2554.3358726731185, 2759.379139693593, 2762.737539933703, 2767.5710264908566, 4916.582090522345, 4919.680220785637, 4922.458529561745, 4928.211486162269, 4938.4320803107385, 5225.817096401608, 5243.449437809051, 5267.183586544092, 5305.495977882095, 5339.652922560022, 4577.0, 4875.756212189376, 4902.313676085422, 4914.574773315699, 4943.925841112458, 5156.375741641371, 5191.351081114861, 5202.0, 5206.843794686166, 5224.791008359623, 4892.339534162842, 5123.487651234846, 5125.2568377585785, 5135.178371460698, 5171.844844654666, 4700.670953033392, 4709.433358819383, 4865.683730557503, 4942.901141977069, 4951.801927922843, 3635.8365323096355, 3639.4722765198367, 3647.1976165243605, 3647.744657873923, 3680.5399325084363, 5169.327987361619, 5181.585473162213, 5192.896142077213, 5210.53105220532, 5216.061109000417, 4920.819003439077, 5002.599792016557, 5005.974970125126, 5046.006827303121, 5067.46791586878, 4968.2795994579865, 4990.451050384528, 5008.524190201925, 5012.77442515095, 5023.598112150946, 4881.560659540658, 4895.485973972682, 4899.730514821719, 4914.812908255792, 4933.235348520985, 4772.832950846704, 5034.489653104128, 5040.395152581567, 5061.924071138862, 5085.38102877026, 4936.580390666833, 4936.950630493793, 4955.4053513577155, 4976.626752993468, 4980.402351717817], "value": 3761.043815956484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.0983505041376, 742.6917829100923, 762.3977058124075, 769.5075151902784, 769.5690413368515, 14274.357653905574, 14527.636809079779, 14556.636084097903, 14557.854421455782, 14559.708805823877, 14122.858771412282, 14211.857881421183, 14239.216843073627, 14240.074395164307, 14261.35823887925, 637.8788030274256, 787.6258777080898, 802.3460879383284, 809.8420807942454, 810.0198759501011, 800.7797855589702, 811.1563973467587, 811.3509192645889, 811.5414790643297, 811.6631597886899, 841.0202114536557, 844.2317491083115, 844.624142256696, 851.1233429567525, 851.2976794144824, 649.3636236488221, 814.3241109878786, 832.2010869565255, 832.8459235041506, 839.9412041157121, 623.6819222196667, 624.3007831229007, 624.3787431505635, 624.9093881387173, 625.0592857749104, 12971.027172962065, 13005.414756335987, 13016.41426135826, 13018.869811301955, 13035.087543871932, 11120.721981950435, 11646.879484391171, 11677.416129193507, 11802.232854864405, 12040.698982525419, 10768.623098191525, 10939.83590246147, 10981.450927453676, 11178.720531986684, 11245.55017799287, 3926.0773718176206, 3941.4481972523868, 3984.820683069269, 4006.258842114218, 4035.2131334389805, 44158.33762493533, 45993.31010034852, 47020.82447938795, 47070.5292947073, 47282.29076563854, 9583.616655333848, 9655.420674759536, 9669.17811985975, 9705.417674939526, 9843.409395436296, 16655.583610409838, 17087.829121708623, 17094.572635684206, 17095.743563846554, 17106.315747370216, 6758.42553382968, 6815.182178138655, 6865.691043903036, 6911.7926462206215, 6978.581285122909, 3550.2544465661986, 3642.21692336149, 3664.6518580734787, 3674.8346324415465, 3695.1870588470492, 2833.1217322629636, 2925.8537073146686, 2938.853057347124, 2944.3522425066453, 2944.5877577139217, 513.8561202863204, 524.8031988004499, 527.0776141751934, 529.4784637132421, 533.0032838591858, 448.6253977928401, 586.9677167755729, 593.3888095261888, 598.7664810723821, 600.8107446154447, 8300.875486867702, 8369.832603347899, 8407.789805254795, 8612.612432440555, 8652.480851148825, 579.6435192356755, 595.2767387624058, 598.5839841310247, 598.6497898729206, 609.9085137229451, 3861.189150278417, 3888.9411951259417, 3954.723169378116, 3980.44273801668, 4007.899802504961, 46344.7682761584, 47941.28088078681, 48140.518594814304, 52030.21954670683, 52726.0, 47734.76132619384, 47788.7610561945, 47853.521464785605, 48310.27534586984, 50393.74803125961, 45983.99999999933, 46576.5342346579, 46594.0, 46949.0, 47191.764041180264, 7792.0, 7809.843803123792, 8339.54132522717, 8405.95797021011, 8508.106648802035, 30722.0, 30756.538651919793, 31228.21929451691, 31238.531422029144, 31323.53014704827, 39878.80363589097, 40218.798906005286, 40787.59212407838, 41011.38482922699, 41501.58498414977, 10177.796444071226, 10201.438920859424, 10295.794084118126, 10471.109955653856, 10480.528376223241, 11194.776104478027, 11519.596814111466, 11530.538778448768, 11787.174897757075, 11837.763244734884, 11214.271072380268, 11224.045956093823, 11244.887551124384, 11418.714532136431, 11489.597864074718, 10851.186161038111, 11054.060404865677, 11130.944345278222, 11137.832932505857, 11453.08375329955, 11042.834357484484, 11045.83431248548, 11625.128115391548, 11680.47437865281, 11681.415929203677, 9071.228945539702, 9223.21602663781, 9250.4912229828, 9444.763880903032, 9487.620495180392, 9081.228095611947, 9156.58795354224, 9339.252859771337, 9343.0, 9526.571304291461], "value": 6067.650921898197, "unit": "score"}], "name": "dromaeo_css", "value": 6291.002735081013, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 116.0, 117.0, 117.0, 114.0, 116.0, 114.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 149.0, 219.0, 135.0, 166.0, 161.0, 130.0, 195.0, 131.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 159.0, 159.0, 162.0, 159.0, 160.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 147.0, 76.0, 77.0, 76.0, 75.0, 132.0, 76.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 155.0, 93.0, 94.0, 94.0, 123.0, 94.0, 94.0, 116.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 115.0, 61.0, 61.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 64.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 89.0, 83.0, 83.0, 84.0, 88.0, 85.0, 85.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 130.0, 141.0, 144.0, 135.0, 127.0, 128.0, 137.0, 264.0, 146.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 174.0, 175.0, 175.0, 172.0, 174.0, 172.0, 172.0, 176.0, 171.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1591.6999999999998, "alertThreshold": 2.0}]} 20:16:11 INFO - Return code: 0 20:16:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:16:11 ERROR - # TBPL SUCCESS # 20:16:11 INFO - Running post-action listener: _resource_record_post_action 20:16:11 INFO - ##### 20:16:11 INFO - ##### Finished run-tests step (success) 20:16:11 INFO - ##### 20:16:11 INFO - Running post-run listener: _resource_record_post_run 20:16:11 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 499712; Write bytes: 305586176; Read time: 48; Write time: 170252 20:16:11 INFO - TinderboxPrint: CPU usage
13.1% 20:16:11 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 48 20:16:11 INFO - TinderboxPrint: I/O write bytes / time
305,586,176 / 170,252 20:16:11 INFO - TinderboxPrint: CPU idle
8,331.3 (86.9%) 20:16:11 INFO - TinderboxPrint: CPU user
1,212.2 (12.6%) 20:16:11 INFO - TinderboxPrint: Swap in / out
0 / 0 20:16:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17821696; Read time: 0; Write time: 4052 20:16:11 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 499712; Write bytes: 287764480; Read time: 48; Write time: 166200 20:16:12 INFO - Running post-run listener: _upload_blobber_files 20:16:12 INFO - Blob upload gear active. 20:16:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:16:12 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 20:16:12 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:16:12 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:16:12 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:16:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:13 INFO - (blobuploader) - INFO - Done attempting. 20:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:14 INFO - (blobuploader) - INFO - Done attempting. 20:16:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:16:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:18 INFO - (blobuploader) - INFO - Done attempting. 20:16:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:18 INFO - Return code: 0 20:16:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:16:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25cccccf705a025952b6d6ddea1f3f323f174bffcf27eadc84d2a7fdacecbc5e3cf554cfdb55a63b50b7173f48fa5cb716b846eb272e55d95b2cfb0aae61df3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1810d8d130096a33f0b66aea96b3920c87483721b628f532042e60920b2cc7cb3838cc72b8f6baff5fface43c4a02b2e1d533256046cf95baafc2dae228b96f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b945dc73b6efe4f61e0535552fbbc8c474bb49c5391aa8f0572c69a8d04e88503d044c3f99c1d1843ac2b028197d575f4740bb25e469f88ea676df8d8814b6c"} 20:16:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:16:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:16:18 INFO - Contents: 20:16:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25cccccf705a025952b6d6ddea1f3f323f174bffcf27eadc84d2a7fdacecbc5e3cf554cfdb55a63b50b7173f48fa5cb716b846eb272e55d95b2cfb0aae61df3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1810d8d130096a33f0b66aea96b3920c87483721b628f532042e60920b2cc7cb3838cc72b8f6baff5fface43c4a02b2e1d533256046cf95baafc2dae228b96f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b945dc73b6efe4f61e0535552fbbc8c474bb49c5391aa8f0572c69a8d04e88503d044c3f99c1d1843ac2b028197d575f4740bb25e469f88ea676df8d8814b6c"} 20:16:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:16:18 INFO - Copying logs to upload dir... 20:16:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:16:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.592766 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-19 20:16:18.194582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 20:16:18.197994) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25cccccf705a025952b6d6ddea1f3f323f174bffcf27eadc84d2a7fdacecbc5e3cf554cfdb55a63b50b7173f48fa5cb716b846eb272e55d95b2cfb0aae61df3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1810d8d130096a33f0b66aea96b3920c87483721b628f532042e60920b2cc7cb3838cc72b8f6baff5fface43c4a02b2e1d533256046cf95baafc2dae228b96f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b945dc73b6efe4f61e0535552fbbc8c474bb49c5391aa8f0572c69a8d04e88503d044c3f99c1d1843ac2b028197d575f4740bb25e469f88ea676df8d8814b6c"} build_url:https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/M32pJbdORpukMdRq9oS1UA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25cccccf705a025952b6d6ddea1f3f323f174bffcf27eadc84d2a7fdacecbc5e3cf554cfdb55a63b50b7173f48fa5cb716b846eb272e55d95b2cfb0aae61df3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1810d8d130096a33f0b66aea96b3920c87483721b628f532042e60920b2cc7cb3838cc72b8f6baff5fface43c4a02b2e1d533256046cf95baafc2dae228b96f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4b945dc73b6efe4f61e0535552fbbc8c474bb49c5391aa8f0572c69a8d04e88503d044c3f99c1d1843ac2b028197d575f4740bb25e469f88ea676df8d8814b6c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 20:16:18.223279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:16:18.223679) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463697645.697208-1592438949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:16:18.308771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 20:16:18.309131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 20:16:18.309476) ========= ========= Total master_lag: 0.17 =========