builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1466674832.78 results: success (0) buildid: 20160622234339 builduid: 4e3100a2684148b3a8f3304c01f61a05 revision: 437fc937572d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.781513) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.781989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.782279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.796762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.797097) ========= 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=41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 02:40: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% 81.5M=0s 2016-06-23 02:40:33 (81.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126788 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.937145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.937479) ========= 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=41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015768 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.989904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:32.990267) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 437fc937572d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 437fc937572d --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=41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 02:40:33,413 Setting DEBUG logging. 2016-06-23 02:40:33,413 attempt 1/10 2016-06-23 02:40:33,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/437fc937572d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 02:40:33,733 unpacking tar archive at: fx-team-437fc937572d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:33.640115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:33.640459) ========= script_repo_revision: 437fc937572d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:33.640868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:33.641137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:40:33.650691) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-23 02:40:33.651046) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:40:34 INFO - MultiFileLogger online at 20160623 02:40:34 in /builds/slave/test 02:40:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:40:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:40:34 INFO - {'append_to_log': False, 02:40:34 INFO - 'base_work_dir': '/builds/slave/test', 02:40:34 INFO - 'blob_upload_branch': 'Fx-Team', 02:40:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:40:34 INFO - 'branch': 'Fx-Team', 02:40:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:40:34 INFO - 'config_files': ('talos/linux_config.py',), 02:40:34 INFO - 'default_actions': ('clobber', 02:40:34 INFO - 'read-buildbot-config', 02:40:34 INFO - 'download-and-extract', 02:40:34 INFO - 'populate-webroot', 02:40:34 INFO - 'create-virtualenv', 02:40:34 INFO - 'install', 02:40:34 INFO - 'run-tests'), 02:40:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:40:34 INFO - 'download_minidump_stackwalk': True, 02:40:34 INFO - 'download_symbols': 'ondemand', 02:40:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:40:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:40:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:40:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:40:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:40:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:40:34 INFO - 'installer_path': 'installer.exe', 02:40:34 INFO - 'log_level': 'info', 02:40:34 INFO - 'log_name': 'talos', 02:40:34 INFO - 'log_to_console': True, 02:40:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:40:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:40:34 INFO - 'opt_config_files': (), 02:40:34 INFO - 'pip_index': False, 02:40:34 INFO - 'sps_profile': False, 02:40:34 INFO - 'sps_profile_interval': 0, 02:40:34 INFO - 'suite': 'dromaeojs', 02:40:34 INFO - 'system_bits': '32', 02:40:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:40:34 INFO - 'title': 'talos-linux64-ix-024', 02:40:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:40:34 INFO - 'use_talos_json': True, 02:40:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:40:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:40:34 INFO - 'work_dir': 'build'} 02:40:34 INFO - ##### 02:40:34 INFO - ##### Running clobber step. 02:40:34 INFO - ##### 02:40:34 INFO - Running pre-action listener: _resource_record_pre_action 02:40:34 INFO - Running main action method: clobber 02:40:34 INFO - rmtree: /builds/slave/test/build 02:40:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:40:34 INFO - Running post-action listener: _resource_record_post_action 02:40:34 INFO - ##### 02:40:34 INFO - ##### Finished clobber step (success) 02:40:34 INFO - ##### 02:40:34 INFO - ##### 02:40:34 INFO - ##### Running read-buildbot-config step. 02:40:34 INFO - ##### 02:40:34 INFO - Running pre-action listener: _resource_record_pre_action 02:40:34 INFO - Running main action method: read_buildbot_config 02:40:34 INFO - Using buildbot properties: 02:40:34 INFO - { 02:40:34 INFO - "project": "", 02:40:34 INFO - "product": "firefox", 02:40:34 INFO - "script_repo_revision": "production", 02:40:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:40:34 INFO - "repository": "", 02:40:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:40:34 INFO - "buildid": "20160622234339", 02:40:34 INFO - "pgo_build": "True", 02:40:34 INFO - "basedir": "/builds/slave/test", 02:40:34 INFO - "buildnumber": 820, 02:40:34 INFO - "slavename": "talos-linux64-ix-024", 02:40:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:40:34 INFO - "platform": "ubuntu64_hw", 02:40:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:40:34 INFO - "branch": "fx-team", 02:40:34 INFO - "repo_path": "integration/fx-team", 02:40:34 INFO - "revision": "437fc937572d", 02:40:34 INFO - "stage_platform": "linux64-pgo", 02:40:34 INFO - "builduid": "4e3100a2684148b3a8f3304c01f61a05", 02:40:34 INFO - "slavebuilddir": "test" 02:40:34 INFO - } 02:40:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:40:34 INFO - Running post-action listener: _resource_record_post_action 02:40:34 INFO - ##### 02:40:34 INFO - ##### Finished read-buildbot-config step (success) 02:40:34 INFO - ##### 02:40:34 INFO - ##### 02:40:34 INFO - ##### Running download-and-extract step. 02:40:34 INFO - ##### 02:40:34 INFO - Running pre-action listener: _resource_record_pre_action 02:40:34 INFO - Running main action method: download_and_extract 02:40:34 INFO - mkdir: /builds/slave/test/build/tests 02:40: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')]} 02:40:34 INFO - https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:40:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:40:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:40:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:40:35 INFO - Downloaded 1361 bytes. 02:40:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:40:35 INFO - Using the following test package requirements: 02:40:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:40:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:40:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:40:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'jsshell-linux-x86_64.zip'], 02:40:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:40:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:40:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:40:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:40:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:40:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:40:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:40:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:40: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')]} 02:40:35 INFO - https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:40:36 INFO - Downloaded 24269472 bytes. 02:40:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:40:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:40:37 INFO - Return code: 0 02:40:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:40: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')]} 02:40:37 INFO - https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:40:38 INFO - Downloaded 24269472 bytes. 02:40:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:40:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:40:40 INFO - Return code: 0 02:40: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')]} 02:40:40 INFO - https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:40:41 INFO - Downloaded 14405384 bytes. 02:40:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:40:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:40:42 INFO - Return code: 0 02:40: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')]} 02:40:42 INFO - https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:40:47 INFO - Downloaded 60160867 bytes. 02:40:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:40:47 INFO - mkdir: /builds/slave/test/properties 02:40:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:40:47 INFO - Writing to file /builds/slave/test/properties/build_url 02:40:47 INFO - Contents: 02:40:47 INFO - build_url:https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:40:48 INFO - Running post-action listener: _resource_record_post_action 02:40:48 INFO - Running post-action listener: set_extra_try_arguments 02:40:48 INFO - ##### 02:40:48 INFO - ##### Finished download-and-extract step (success) 02:40:48 INFO - ##### 02:40:48 INFO - ##### 02:40:48 INFO - ##### Running populate-webroot step. 02:40:48 INFO - ##### 02:40:48 INFO - Running pre-action listener: _resource_record_pre_action 02:40:48 INFO - Running main action method: populate_webroot 02:40:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:40:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:40:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:40:48 INFO - '--tppagecycles', 02:40:48 INFO - '7'], 02:40:48 INFO - 'tests': ['tsvgm']}}, 02:40:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:40:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:40:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:40:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:40:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['damp', 'tps']}, 02:40:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'tests': ['damp', 'tps']}, 02:40:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['dromaeo_dom']}, 02:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:40:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['basic_compositor_video']}, 02:40:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:40:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['a11yr', 02:40:48 INFO - 'ts_paint', 02:40:48 INFO - 'tpaint', 02:40:48 INFO - 'sessionrestore', 02:40:48 INFO - 'sessionrestore_no_auto_restore', 02:40:48 INFO - 'tabpaint']}, 02:40:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:40:48 INFO - 'ts_paint', 02:40:48 INFO - 'tpaint', 02:40:48 INFO - 'sessionrestore', 02:40:48 INFO - 'sessionrestore_no_auto_restore', 02:40:48 INFO - 'tabpaint']}, 02:40:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:40:48 INFO - 'ts_paint', 02:40:48 INFO - 'tpaint', 02:40:48 INFO - 'sessionrestore', 02:40:48 INFO - 'sessionrestore_no_auto_restore', 02:40:48 INFO - 'tabpaint']}, 02:40:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:40:48 INFO - 'ts_paint', 02:40:48 INFO - 'tpaint', 02:40:48 INFO - 'sessionrestore', 02:40:48 INFO - 'sessionrestore_no_auto_restore', 02:40:48 INFO - 'tabpaint']}, 02:40:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['a11yr', 02:40:48 INFO - 'ts_paint', 02:40:48 INFO - 'tpaint', 02:40:48 INFO - 'sessionrestore', 02:40:48 INFO - 'sessionrestore_no_auto_restore', 02:40:48 INFO - 'tabpaint']}, 02:40:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['a11yr', 02:40:48 INFO - 'ts_paint', 02:40:48 INFO - 'tpaint', 02:40:48 INFO - 'sessionrestore', 02:40:48 INFO - 'sessionrestore_no_auto_restore', 02:40:48 INFO - 'tabpaint']}, 02:40:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['tsvgx', 02:40:48 INFO - 'tsvgr_opacity', 02:40:48 INFO - 'tart', 02:40:48 INFO - 'tscrollx', 02:40:48 INFO - 'cart']}, 02:40:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:40:48 INFO - 'tsvgr_opacity', 02:40:48 INFO - 'tart', 02:40:48 INFO - 'tscrollx', 02:40:48 INFO - 'cart']}, 02:40:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'talos_options': ['--disable-e10s'], 02:40:48 INFO - 'tests': ['tp5o']}, 02:40:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'tests': ['tp5o']}, 02:40:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'talos_options': ['--disable-e10s', 02:40:48 INFO - '--xperf_path', 02:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:40:48 INFO - 'tests': ['tp5n']}, 02:40:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:48 INFO - 'talos_options': ['--xperf_path', 02:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:40:48 INFO - 'tests': ['tp5n']}}, 02:40:48 INFO - 'talos.zip': {'path': '', 02:40:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:40:48 INFO - Running post-action listener: _resource_record_post_action 02:40:48 INFO - ##### 02:40:48 INFO - ##### Finished populate-webroot step (success) 02:40:48 INFO - ##### 02:40:48 INFO - ##### 02:40:48 INFO - ##### Running create-virtualenv step. 02:40:48 INFO - ##### 02:40:48 INFO - Running pre-action listener: _resource_record_pre_action 02:40:48 INFO - Running main action method: create_virtualenv 02:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:40:48 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 02:40:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:40:48 INFO - Using real prefix '/usr' 02:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:40:48 INFO - Installing distribute.............................................................................................................................................................................................done. 02:40:50 INFO - Installing pip.................done. 02:40:50 INFO - Return code: 0 02:40:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:40: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', 'pip>=1.5'] in /builds/slave/test/build 02:40: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 pip>=1.5 02:40:50 INFO - Using env: {'DISPLAY': ':0', 02:40:50 INFO - 'HOME': '/home/cltbld', 02:40:50 INFO - 'LANG': 'en_US.UTF-8', 02:40:50 INFO - 'LANGUAGE': 'en_US:en', 02:40:50 INFO - 'LOGNAME': 'cltbld', 02:40:50 INFO - 'MAIL': '/var/mail/cltbld', 02:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:50 INFO - 'MOZ_NO_REMOTE': '1', 02:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:50 INFO - 'NO_EM_RESTART': '1', 02:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:50 INFO - 'PWD': '/builds/slave/test', 02:40:50 INFO - 'SHELL': '/bin/bash', 02:40:50 INFO - 'SHLVL': '1', 02:40:50 INFO - 'TERM': 'linux', 02:40:50 INFO - 'TMOUT': '86400', 02:40:50 INFO - 'USER': 'cltbld', 02:40:50 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:50 INFO - '_': '/tools/buildbot/bin/python'} 02:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:50 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 02:40:50 INFO - Cleaning up... 02:40:50 INFO - Return code: 0 02:40:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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', '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 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:40: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:40: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 psutil>=3.1.1 02:40:50 INFO - Using env: {'DISPLAY': ':0', 02:40:50 INFO - 'HOME': '/home/cltbld', 02:40:50 INFO - 'LANG': 'en_US.UTF-8', 02:40:50 INFO - 'LANGUAGE': 'en_US:en', 02:40:50 INFO - 'LOGNAME': 'cltbld', 02:40:50 INFO - 'MAIL': '/var/mail/cltbld', 02:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:50 INFO - 'MOZ_NO_REMOTE': '1', 02:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:50 INFO - 'NO_EM_RESTART': '1', 02:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:50 INFO - 'PWD': '/builds/slave/test', 02:40:50 INFO - 'SHELL': '/bin/bash', 02:40:50 INFO - 'SHLVL': '1', 02:40:50 INFO - 'TERM': 'linux', 02:40:50 INFO - 'TMOUT': '86400', 02:40:50 INFO - 'USER': 'cltbld', 02:40:50 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:50 INFO - '_': '/tools/buildbot/bin/python'} 02:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:51 INFO - Downloading/unpacking psutil>=3.1.1 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:53 INFO - Installing collected packages: psutil 02:40:53 INFO - Running setup.py install for psutil 02:40:53 INFO - building 'psutil._psutil_linux' extension 02:40:53 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 02:40:53 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 02:40:53 INFO - building 'psutil._psutil_posix' extension 02:40:53 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 02:40:53 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 02:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:53 INFO - Successfully installed psutil 02:40:53 INFO - Cleaning up... 02:40:53 INFO - Return code: 0 02:40:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:40: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 mozsystemmonitor==0.3 02:40:53 INFO - Using env: {'DISPLAY': ':0', 02:40:53 INFO - 'HOME': '/home/cltbld', 02:40:53 INFO - 'LANG': 'en_US.UTF-8', 02:40:53 INFO - 'LANGUAGE': 'en_US:en', 02:40:53 INFO - 'LOGNAME': 'cltbld', 02:40:53 INFO - 'MAIL': '/var/mail/cltbld', 02:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:53 INFO - 'MOZ_NO_REMOTE': '1', 02:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:53 INFO - 'NO_EM_RESTART': '1', 02:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:53 INFO - 'PWD': '/builds/slave/test', 02:40:53 INFO - 'SHELL': '/bin/bash', 02:40:53 INFO - 'SHLVL': '1', 02:40:53 INFO - 'TERM': 'linux', 02:40:53 INFO - 'TMOUT': '86400', 02:40:53 INFO - 'USER': 'cltbld', 02:40:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:53 INFO - '_': '/tools/buildbot/bin/python'} 02:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:40:55 INFO - Installing collected packages: mozsystemmonitor 02:40:55 INFO - Running setup.py install for mozsystemmonitor 02:40:55 INFO - Successfully installed mozsystemmonitor 02:40:55 INFO - Cleaning up... 02:40:55 INFO - Return code: 0 02:40:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:40:55 INFO - Using env: {'DISPLAY': ':0', 02:40:55 INFO - 'HOME': '/home/cltbld', 02:40:55 INFO - 'LANG': 'en_US.UTF-8', 02:40:55 INFO - 'LANGUAGE': 'en_US:en', 02:40:55 INFO - 'LOGNAME': 'cltbld', 02:40:55 INFO - 'MAIL': '/var/mail/cltbld', 02:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:55 INFO - 'MOZ_NO_REMOTE': '1', 02:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:55 INFO - 'NO_EM_RESTART': '1', 02:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:55 INFO - 'PWD': '/builds/slave/test', 02:40:55 INFO - 'SHELL': '/bin/bash', 02:40:55 INFO - 'SHLVL': '1', 02:40:55 INFO - 'TERM': 'linux', 02:40:55 INFO - 'TMOUT': '86400', 02:40:55 INFO - 'USER': 'cltbld', 02:40:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:55 INFO - '_': '/tools/buildbot/bin/python'} 02:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:56 INFO - Downloading/unpacking jsonschema==2.5.1 02:40:56 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 02:40:56 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 02:40:56 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 02:40:56 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 02:40:56 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 02:40:56 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 02:40:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:40:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:40:58 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 02:40:58 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 02:40:58 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 02:40:58 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 02:40:58 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 02:40:58 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 02:40:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:40:58 INFO - warning: no files found matching '*.txt' 02:40:58 INFO - no previously-included directories found matching 'build' 02:40:58 INFO - no previously-included directories found matching 'dist' 02:40:58 INFO - no previously-included directories found matching '.git*' 02:40:58 INFO - Installing collected packages: jsonschema, functools32 02:40:58 INFO - Running setup.py install for functools32 02:40:58 INFO - warning: no files found matching '*.txt' 02:40:58 INFO - no previously-included directories found matching 'build' 02:40:58 INFO - no previously-included directories found matching 'dist' 02:40:58 INFO - no previously-included directories found matching '.git*' 02:40:58 INFO - Successfully installed jsonschema functools32 02:40:58 INFO - Cleaning up... 02:40:58 INFO - Return code: 0 02:40:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:58 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 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:40:58 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 02:40:58 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 02:40:58 INFO - Using env: {'DISPLAY': ':0', 02:40:58 INFO - 'HOME': '/home/cltbld', 02:40:58 INFO - 'LANG': 'en_US.UTF-8', 02:40:58 INFO - 'LANGUAGE': 'en_US:en', 02:40:58 INFO - 'LOGNAME': 'cltbld', 02:40:58 INFO - 'MAIL': '/var/mail/cltbld', 02:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:58 INFO - 'MOZ_NO_REMOTE': '1', 02:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:58 INFO - 'NO_EM_RESTART': '1', 02:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:58 INFO - 'PWD': '/builds/slave/test', 02:40:58 INFO - 'SHELL': '/bin/bash', 02:40:58 INFO - 'SHLVL': '1', 02:40:58 INFO - 'TERM': 'linux', 02:40:58 INFO - 'TMOUT': '86400', 02:40:58 INFO - 'USER': 'cltbld', 02:40:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:58 INFO - '_': '/tools/buildbot/bin/python'} 02:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:40:58 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 02:40:58 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 02:40:58 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 02:40:58 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 02:40:58 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 02:40:58 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 02:41:00 INFO - Downloading blobuploader-1.2.4.tar.gz 02:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:41:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:41:00 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 02:41:00 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 02:41:00 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 02:41:00 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 02:41:00 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 02:41:00 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 02:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:41:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41:01 INFO - Downloading docopt-0.6.1.tar.gz 02:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:41:01 INFO - Running setup.py install for blobuploader 02:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:41:01 INFO - Running setup.py install for requests 02:41:02 INFO - Running setup.py install for docopt 02:41:02 INFO - Successfully installed blobuploader requests docopt 02:41:02 INFO - Cleaning up... 02:41:02 INFO - Return code: 0 02:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:02 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 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:41:02 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 02:41:02 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 02:41:02 INFO - Using env: {'DISPLAY': ':0', 02:41:02 INFO - 'HOME': '/home/cltbld', 02:41:02 INFO - 'LANG': 'en_US.UTF-8', 02:41:02 INFO - 'LANGUAGE': 'en_US:en', 02:41:02 INFO - 'LOGNAME': 'cltbld', 02:41:02 INFO - 'MAIL': '/var/mail/cltbld', 02:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:02 INFO - 'MOZ_NO_REMOTE': '1', 02:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:02 INFO - 'NO_EM_RESTART': '1', 02:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:02 INFO - 'PWD': '/builds/slave/test', 02:41:02 INFO - 'SHELL': '/bin/bash', 02:41:02 INFO - 'SHLVL': '1', 02:41:02 INFO - 'TERM': 'linux', 02:41:02 INFO - 'TMOUT': '86400', 02:41:02 INFO - 'USER': 'cltbld', 02:41:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:02 INFO - '_': '/tools/buildbot/bin/python'} 02:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:02 INFO - Running setup.py (path:/tmp/pip-8u99YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:02 INFO - Running setup.py (path:/tmp/pip-itL95h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:02 INFO - Running setup.py (path:/tmp/pip-h464DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:02 INFO - Running setup.py (path:/tmp/pip-MKWhuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:02 INFO - Running setup.py (path:/tmp/pip-ZJHJaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:02 INFO - Running setup.py (path:/tmp/pip-irnc3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:02 INFO - Running setup.py (path:/tmp/pip-DYzOl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:02 INFO - Running setup.py (path:/tmp/pip-baAeSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:03 INFO - Running setup.py (path:/tmp/pip-QvtQ5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:03 INFO - Running setup.py (path:/tmp/pip-_T2I9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:03 INFO - Running setup.py (path:/tmp/pip-bLjRIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:03 INFO - Running setup.py (path:/tmp/pip-HOfnby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:03 INFO - Running setup.py (path:/tmp/pip-LD8yEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:03 INFO - Running setup.py (path:/tmp/pip-7y359r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:03 INFO - Running setup.py (path:/tmp/pip-mlvmEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:03 INFO - Running setup.py (path:/tmp/pip-Vq27Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:03 INFO - Running setup.py (path:/tmp/pip-4OoFYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:41:03 INFO - Running setup.py install for manifestparser 02:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:41:03 INFO - Running setup.py install for mozcrash 02:41:03 INFO - Running setup.py install for mozdebug 02:41:03 INFO - Running setup.py install for mozdevice 02:41:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Running setup.py install for mozfile 02:41:04 INFO - Running setup.py install for mozhttpd 02:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Running setup.py install for mozinfo 02:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Running setup.py install for mozInstall 02:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Running setup.py install for mozleak 02:41:04 INFO - Running setup.py install for mozlog 02:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Running setup.py install for moznetwork 02:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Running setup.py install for mozprocess 02:41:04 INFO - Running setup.py install for mozprofile 02:41:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Running setup.py install for mozrunner 02:41:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:41:05 INFO - Running setup.py install for mozscreenshot 02:41:05 INFO - Running setup.py install for moztest 02:41:05 INFO - Running setup.py install for mozversion 02:41:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:41:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:41:05 INFO - Cleaning up... 02:41:05 INFO - Return code: 0 02:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:05 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 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:41:05 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 02:41:05 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 02:41:05 INFO - Using env: {'DISPLAY': ':0', 02:41:05 INFO - 'HOME': '/home/cltbld', 02:41:05 INFO - 'LANG': 'en_US.UTF-8', 02:41:05 INFO - 'LANGUAGE': 'en_US:en', 02:41:05 INFO - 'LOGNAME': 'cltbld', 02:41:05 INFO - 'MAIL': '/var/mail/cltbld', 02:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:05 INFO - 'MOZ_NO_REMOTE': '1', 02:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:05 INFO - 'NO_EM_RESTART': '1', 02:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:05 INFO - 'PWD': '/builds/slave/test', 02:41:05 INFO - 'SHELL': '/bin/bash', 02:41:05 INFO - 'SHLVL': '1', 02:41:05 INFO - 'TERM': 'linux', 02:41:05 INFO - 'TMOUT': '86400', 02:41:05 INFO - 'USER': 'cltbld', 02:41:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:05 INFO - '_': '/tools/buildbot/bin/python'} 02:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:05 INFO - Running setup.py (path:/tmp/pip-Fp9gY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:05 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)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:05 INFO - Running setup.py (path:/tmp/pip-wXGTOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:05 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)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:05 INFO - Running setup.py (path:/tmp/pip-Z3Gl9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:05 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)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:05 INFO - Running setup.py (path:/tmp/pip-zKhFbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:05 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)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:05 INFO - Running setup.py (path:/tmp/pip-U_wOtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:06 INFO - Running setup.py (path:/tmp/pip-qZ95da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:06 INFO - Running setup.py (path:/tmp/pip-TDWMzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:06 INFO - Running setup.py (path:/tmp/pip-uuoSzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:06 INFO - Running setup.py (path:/tmp/pip-uVJwNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:06 INFO - Running setup.py (path:/tmp/pip-BnQcNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:06 INFO - Running setup.py (path:/tmp/pip-o44oWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:06 INFO - Running setup.py (path:/tmp/pip-spzs_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:06 INFO - Running setup.py (path:/tmp/pip-kJYXHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:06 INFO - Running setup.py (path:/tmp/pip-ZyfbcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:06 INFO - Running setup.py (path:/tmp/pip-cEpqDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:06 INFO - Running setup.py (path:/tmp/pip-ZqoEER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:06 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)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:06 INFO - Running setup.py (path:/tmp/pip-kuyuql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:06 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)) 02:41:06 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)) 02:41:06 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)) 02:41:06 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)) 02:41:06 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)) 02:41:06 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)) 02:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41:08 INFO - Downloading blessings-1.6.tar.gz 02:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:41:08 INFO - Installing collected packages: blessings 02:41:08 INFO - Running setup.py install for blessings 02:41:09 INFO - Successfully installed blessings 02:41:09 INFO - Cleaning up... 02:41:09 INFO - Return code: 0 02:41:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:09 INFO - Reading from file tmpfile_stdout 02:41:09 INFO - Current package versions: 02:41:09 INFO - argparse == 1.2.1 02:41:09 INFO - blessings == 1.6 02:41:09 INFO - blobuploader == 1.2.4 02:41:09 INFO - docopt == 0.6.1 02:41:09 INFO - functools32 == 3.2.3-2 02:41:09 INFO - jsonschema == 2.5.1 02:41:09 INFO - manifestparser == 1.1 02:41:09 INFO - mozInstall == 1.12 02:41:09 INFO - mozcrash == 0.17 02:41:09 INFO - mozdebug == 0.1 02:41:09 INFO - mozdevice == 0.48 02:41:09 INFO - mozfile == 1.2 02:41:09 INFO - mozhttpd == 0.7 02:41:09 INFO - mozinfo == 0.9 02:41:09 INFO - mozleak == 0.1 02:41:09 INFO - mozlog == 3.2 02:41:09 INFO - moznetwork == 0.27 02:41:09 INFO - mozprocess == 0.22 02:41:09 INFO - mozprofile == 0.28 02:41:09 INFO - mozrunner == 6.11 02:41:09 INFO - mozscreenshot == 0.1 02:41:09 INFO - mozsystemmonitor == 0.3 02:41:09 INFO - moztest == 0.7 02:41:09 INFO - mozversion == 1.4 02:41:09 INFO - psutil == 3.1.1 02:41:09 INFO - requests == 1.2.3 02:41:09 INFO - wsgiref == 0.1.2 02:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 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 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:41:09 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 02:41:09 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 02:41:09 INFO - Using env: {'DISPLAY': ':0', 02:41:09 INFO - 'HOME': '/home/cltbld', 02:41:09 INFO - 'LANG': 'en_US.UTF-8', 02:41:09 INFO - 'LANGUAGE': 'en_US:en', 02:41:09 INFO - 'LOGNAME': 'cltbld', 02:41:09 INFO - 'MAIL': '/var/mail/cltbld', 02:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:09 INFO - 'MOZ_NO_REMOTE': '1', 02:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:09 INFO - 'NO_EM_RESTART': '1', 02:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:09 INFO - 'PWD': '/builds/slave/test', 02:41:09 INFO - 'SHELL': '/bin/bash', 02:41:09 INFO - 'SHLVL': '1', 02:41:09 INFO - 'TERM': 'linux', 02:41:09 INFO - 'TMOUT': '86400', 02:41:09 INFO - 'USER': 'cltbld', 02:41:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:09 INFO - '_': '/tools/buildbot/bin/python'} 02:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 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)) 02:41:09 INFO - Cleaning up... 02:41:09 INFO - Return code: 0 02:41:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:41:09 INFO - Using env: {'DISPLAY': ':0', 02:41:09 INFO - 'HOME': '/home/cltbld', 02:41:09 INFO - 'LANG': 'en_US.UTF-8', 02:41:09 INFO - 'LANGUAGE': 'en_US:en', 02:41:09 INFO - 'LOGNAME': 'cltbld', 02:41:09 INFO - 'MAIL': '/var/mail/cltbld', 02:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:09 INFO - 'MOZ_NO_REMOTE': '1', 02:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:09 INFO - 'NO_EM_RESTART': '1', 02:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:09 INFO - 'PWD': '/builds/slave/test', 02:41:09 INFO - 'SHELL': '/bin/bash', 02:41:09 INFO - 'SHLVL': '1', 02:41:09 INFO - 'TERM': 'linux', 02:41:09 INFO - 'TMOUT': '86400', 02:41:09 INFO - 'USER': 'cltbld', 02:41:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:09 INFO - '_': '/tools/buildbot/bin/python'} 02:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:41:09 INFO - Cleaning up... 02:41:09 INFO - Return code: 0 02:41:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef22255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, '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': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', '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 02:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:41:09 INFO - Using env: {'DISPLAY': ':0', 02:41:09 INFO - 'HOME': '/home/cltbld', 02:41:09 INFO - 'LANG': 'en_US.UTF-8', 02:41:09 INFO - 'LANGUAGE': 'en_US:en', 02:41:09 INFO - 'LOGNAME': 'cltbld', 02:41:09 INFO - 'MAIL': '/var/mail/cltbld', 02:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:09 INFO - 'MOZ_NO_REMOTE': '1', 02:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:09 INFO - 'NO_EM_RESTART': '1', 02:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:09 INFO - 'PWD': '/builds/slave/test', 02:41:09 INFO - 'SHELL': '/bin/bash', 02:41:09 INFO - 'SHLVL': '1', 02:41:09 INFO - 'TERM': 'linux', 02:41:09 INFO - 'TMOUT': '86400', 02:41:09 INFO - 'USER': 'cltbld', 02:41:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:09 INFO - '_': '/tools/buildbot/bin/python'} 02:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:09 INFO - Downloading/unpacking flake8 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:41:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:41:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:12 INFO - no previously-included directories found matching 'docs/_build' 02:41:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:41:12 INFO - Running setup.py install for pep8 02:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:12 INFO - no previously-included directories found matching 'docs/_build' 02:41:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:41:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:41:12 INFO - Cleaning up... 02:41:12 INFO - Return code: 0 02:41:12 INFO - Running post-action listener: _resource_record_post_action 02:41:12 INFO - Running post-action listener: _start_resource_monitoring 02:41:12 INFO - Starting resource monitoring. 02:41:12 INFO - ##### 02:41:12 INFO - ##### Finished create-virtualenv step (success) 02:41:12 INFO - ##### 02:41:12 INFO - ##### 02:41:12 INFO - ##### Running install step. 02:41:12 INFO - ##### 02:41:12 INFO - Running pre-action listener: _resource_record_pre_action 02:41:12 INFO - Running main action method: install 02:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:13 INFO - Reading from file tmpfile_stdout 02:41:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:41:13 INFO - Reading from file tmpfile_stdout 02:41:13 INFO - Output received: 02:41:13 INFO - Usage: mozinstall [options] installer 02:41:13 INFO - Options: 02:41:13 INFO - -h, --help show this help message and exit 02:41:13 INFO - -d DEST, --destination=DEST 02:41:13 INFO - Directory to install application into. [default: 02:41:13 INFO - "/builds/slave/test"] 02:41:13 INFO - --app=APP Application being installed. [default: firefox] 02:41:13 INFO - mkdir: /builds/slave/test/build/application 02:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:41:30 INFO - Reading from file tmpfile_stdout 02:41:30 INFO - Output received: 02:41:30 INFO - /builds/slave/test/build/application/firefox/firefox 02:41:30 INFO - Running post-action listener: _resource_record_post_action 02:41:30 INFO - ##### 02:41:30 INFO - ##### Finished install step (success) 02:41:30 INFO - ##### 02:41:30 INFO - ##### 02:41:30 INFO - ##### Running run-tests step. 02:41:30 INFO - ##### 02:41:30 INFO - Running pre-action listener: _resource_record_pre_action 02:41:30 INFO - Running main action method: run_tests 02:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:41:30 INFO - Python 2.7.3 02:41:30 INFO - Return code: 0 02:41:30 INFO - grabbing minidump binary from tooltool 02:41:30 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')]} 02:41:30 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 0x1e5d1c0>, '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 0x1e5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:41:30 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 02:41:30 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 02:41:30 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 02:41:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:41:30 INFO - Return code: 0 02:41:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:41:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:41:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:41:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:41:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:41:31 INFO - Return code: 0 02:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 02:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 02:41:31 INFO - Using env: {'DISPLAY': ':0', 02:41:31 INFO - 'HOME': '/home/cltbld', 02:41:31 INFO - 'LANG': 'en_US.UTF-8', 02:41:31 INFO - 'LANGUAGE': 'en_US:en', 02:41:31 INFO - 'LOGNAME': 'cltbld', 02:41:31 INFO - 'MAIL': '/var/mail/cltbld', 02:41:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:41:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:31 INFO - 'MOZ_NO_REMOTE': '1', 02:41:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:31 INFO - 'NO_EM_RESTART': '1', 02:41:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:31 INFO - 'PWD': '/builds/slave/test', 02:41:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:41:31 INFO - 'SHELL': '/bin/bash', 02:41:31 INFO - 'SHLVL': '1', 02:41:31 INFO - 'TERM': 'linux', 02:41:31 INFO - 'TMOUT': '86400', 02:41:31 INFO - 'USER': 'cltbld', 02:41:31 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729', 02:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:31 INFO - '_': '/tools/buildbot/bin/python'} 02:41:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 02:41:31 INFO - mozversion application_buildid: 20160622234339 02:41:31 INFO - mozversion application_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 02:41:31 INFO - mozversion application_display_name: Nightly 02:41:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:41:31 INFO - mozversion application_name: Firefox 02:41:31 INFO - mozversion application_remotingname: firefox 02:41:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:41:31 INFO - mozversion application_vendor: Mozilla 02:41:31 INFO - mozversion application_version: 50.0a1 02:41:31 INFO - mozversion platform_buildid: 20160622234339 02:41:31 INFO - mozversion platform_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 02:41:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:41:31 INFO - mozversion platform_version: 50.0a1 02:41:31 INFO - using testdate: 1466674891 02:41:31 INFO - actual date: 1466674891 02:41:31 INFO - starting webserver on 'localhost:46049' 02:41:31 INFO - SUITE-START | Running 2 tests 02:41:31 INFO - TEST-START | dromaeo_css 02:41:31 INFO - operating with platform_type : linux_ 02:41:31 INFO - Initialising browser for dromaeo_css test... 02:41:31 INFO - TEST-INFO | started process 15640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2vsv_/profile http://localhost:46049/getInfo.html) 02:41:35 INFO - PROCESS | 15640 | __metrics Screen width/height:1600/1200 02:41:35 INFO - PROCESS | 15640 | colorDepth:24 02:41:35 INFO - PROCESS | 15640 | Browser inner width/height: 1024/697 02:41:35 INFO - PROCESS | 15640 | __metrics 02:41:36 INFO - PROCESS | 15640 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:41:37 INFO - TEST-INFO | 15640: exit 0 02:41:37 INFO - Browser initialized. 02:41:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:41:37 INFO - TEST-INFO | started process 15721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2vsv_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:41:49 INFO - PROCESS | 15721 | RSS: Main: 174125056 02:41:49 INFO - PROCESS | 15721 | 02:42:40 INFO - PROCESS | 15721 | 1466674960179 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] 02:44:49 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:46049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46049/tests/dromaeo/cssquery-ext.html) 02:44:50 INFO - PROCESS | 15721 | RSS: Main: 281600000 02:44:50 INFO - PROCESS | 15721 | 02:47:52 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:46049/tests/dromaeo/cssquery-ext.html (next: http://localhost:46049/tests/dromaeo/cssquery-jquery.html) 02:47:53 INFO - PROCESS | 15721 | RSS: Main: 264163328 02:47:53 INFO - PROCESS | 15721 | 02:50:55 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:46049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46049/tests/dromaeo/cssquery-mootools.html) 02:50:55 INFO - PROCESS | 15721 | RSS: Main: 266215424 02:50:55 INFO - PROCESS | 15721 | 02:53:57 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:46049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46049/tests/dromaeo/cssquery-prototype.html) 02:53:58 INFO - PROCESS | 15721 | RSS: Main: 256786432 02:53:58 INFO - PROCESS | 15721 | 02:57:01 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:46049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46049/tests/dromaeo/cssquery-yui.html) 02:57:01 INFO - PROCESS | 15721 | RSS: Main: 243912704 02:57:01 INFO - PROCESS | 15721 | 03:00:04 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:46049/tests/dromaeo/cssquery-yui.html (next: http://localhost:46049/tests/dromaeo/cssquery-dojo.html) 03:00:05 INFO - PROCESS | 15721 | RSS: Main: 298233856 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | __start_tp_report 03:00:05 INFO - PROCESS | 15721 | _x_x_mozilla_page_load 03:00:05 INFO - PROCESS | 15721 | _x_x_mozilla_page_load_details 03:00:05 INFO - PROCESS | 15721 | |i|pagename|runs| 03:00:05 INFO - PROCESS | 15721 | |0;dojo.html;3102.1314032071023;3120.2511397264648;3144.842757862107;3165.224519992599;3173.30187358781;5278.947210527894;5346.198070289449;5346.572274218063;5456.345238571372;5467.753951072196;5259.263703081571;5260.658057226277;5428.864278393042;5458.699771512565;5509.752061157247;4705.341252224691;4816.63875209359;4828.46886842447;4839.516048395168;5019.046381187581;4964;4996.850094497171;5010.423801262847;5026.849194524152;5067.417247016603;4812.639052071091;4821.421429428456;4846.684965477232;4862.562369386755;4873.561379475864;4769.070031343889;4776.952230477686;4778.068276686047;4957;4966.2798894160505;4821.68659037165;4849.151398505247;4882.804687812483;4899.55903968641;4919.08996835583;5280.788768449257;5293.497117773805;5402.567794576425;5435.374931882845;5440.020796256672;5660.85847853807;5763.308402991626;5766.279215098113;5767.221425107598;5769.163471296681;5768.74040668171;5768.971155144198;5833.38749431312;5834.5915785895;5836.095405212199;5258;5335.279737235501;5359.544438722674;5444.210589464545;5451.836444906659;5899.852503687443;5909.054551271776;5909.852253693692;5920.703964801829;5924.970375148183;5684.118961560965;5691.345495268014;5694.9430505695245;5696.11710184922;5704.80033198836;5602.719864006865;5629.352624448159;5670.7731690732735;5671.829845104653;5761.942380576141;5710.571707121982;5710.942890571124;5715.942840571624;5716.485516303553;5717.656940583578;5673;5714;5717.828465146053;5719.3422756382715;5725.227094342294;4324.913501729948;4329.545397733255;4363.825446982085;4422.867313980586;4428.623566996777;3870.670992965573;3891.7664940103687;3996.080901392696;4007.699422543321;4008.4388185654034;5391.110466773017;5395.082835917903;5395.946040539623;5404.405515393303;5447.428020057916;5729.914051289234;5733.569982251348;5734.397888221677;5736.368999410061;5767.942320576824;5178.559822415062;5287.471252874681;5335.67985920846;5389.865253368697;5399.217113518518;4763.261694437368;4798.592119669797;4803.543663351976;4811.158047341702;4835.202191638411;5858.209141765892;5908.645481271137;5914.02418600926;5917.881642367129;5969;5578.414266502121;5692.203091567101;5719.714014299351;5720.17057526648;5730.541556675373;5958.433948774859;5981.252343457068;5991.64050156992;5993.940060599338;5999.91000135007;5692.914606280826;5707.714614269187;5711.400302968294;5713.22871412354;5713.400092990342;5551.528120109674;5711.714414279352;5760.0783874579865;5771.826845194651;5800.100984347433;5672.659640421588;5672.829815105553;5673.319201695823;5675.091985282335;5682.829515114553;5572.247746554163;5572.804951826666;5611.607187496836;5617.241672374177;5617.691026993554;5385.919211211756;5402.891942161214;5452.2094296327605;5467.507924286833;5492.148716948879;5601.075822489406;5681.431856814285;5687.601867869375;5694.914576281276;5698.116791897262;5382.3541175059245;5533.253010843485;5534.889302213853;5541.667499950016;5542.806001789918 03:00:05 INFO - PROCESS | 15721 | |1;ext.html;548.6899901555621;571.4456976732567;584.4710536964047;586.6069733278703;597.8684689368338;26729.465410691773;27225.455490890196;29138.12585622432;38342.8082859586;39987;33964.66035339646;34091;34153.316933661314;34191.31617367651;34249.65750342496;8458.196471335228;8577.785555361104;8597.484150950962;8599.398042137052;8601.95699021507;8500.78748031298;8583.699570515033;8587.441816281953;8592.312614990817;8593.484390936565;8630.870536941951;8669.306455483546;8673.306135509145;8673.869891951594;8673.95663021684;8559.22966932976;8591.05498395176;8596.312295016383;8600.440971336842;8603.698870539532;8330.62512186953;8394.202550757669;8487.278581320596;8516.957415212946;8543.95728021362;35958.280834383426;36061.27877442436;36249.45625815615;36309.63690363089;36340.27319453596;3339.5491608632765;3488.232588830453;3497.545319108525;3511.877084302063;3617.403128483797;28456.573151402747;28620.284492887637;28964;29318.41363172746;29948.550771738443;4037.253108174997;4037.7981100944835;4051.898702532431;4088.1414902870433;4152.565991161364;344912;348511;348739;349492;350537;44234;44334.778326108164;44501.55498445039;44527.777361113636;44562;43792.343114853305;47837.28244076342;47848.52151478441;48301;48972.26541601879;14185.432582696783;14491.420343186366;14514.056586321854;14514.201718905562;14526.491572794901;11352.886471135349;11434.542618295174;11436.485358158903;11436.94281528587;11444.084473242287;12259.264444133381;13032.087753857328;13249.668758280928;13396.330183490787;13415.798763018562;5540.9168862467095;5610.663360198401;5641.605087643826;5673.574481913873;5703.828885133453;830.8836762853206;875.4484674654926;894.0790985285166;918.3663272342062;943.712167788831;27916.30209244785;28134.29664258369;28299;28356.71643283541;28374.71625283762;945.333539854401;955.9378640388353;964.9228061755043;1019.4189312092036;1029.552144817007;14670.926645366704;14826.33281502335;15129.47046853355;15139;15188.316525756367;509586;509985;513089;513777;514245;46821.5317846824;46963.76518117456;46971;46984.06031879343;46997.29504057442;1060.411471633251;1090.8581884354983;1116.9720756980978;1130.6947124276398;1139.2765593847967;27227;29397;29796.10611681653;30011.549826753053;30013.699863001963;40685.38971915483;40891.59108408878;40995.79502102471;41029.38455923223;41475.37786933138;318646;320587;320770;321076;321419;28516.287092822844;34498.9650310481;36154.4576831353;36199.45700814542;36991.44512832256;40127.79936100301;40245.1950960985;40708.59291407166;41042;41053;34124;34582.654173457944;35117.824410878806;35587.644123558435;35606;34729.82635086808;35178.82410587931;35210;35474.467882982295;35606.821965890005;34514.48228276628;35268.823655881555;35404.64595354014;35448.113797155274;35672.28655426929;31040.844795775876;31574.842125789222;31725;32375;32437.35125297528;24375.878120609283;27543.449131017667;27641.585376219777;27751.167464976083;28050.859745701142 03:00:05 INFO - PROCESS | 15721 | |2;jquery.html;365.005246328813;367.8528588564574;373.9046543131501;382.7971175277104;387.42274011722526;16415.67168656626;18068;18359.173837177324;18744.343947961825;18773.2490700372;15758.527244182693;16145.677086458292;16354.182290885468;16366.099864507447;16376.83623163768;5370.221317908901;5587.720613969285;5606.074997625407;5626.521745651625;5661.207430959669;4116.97941510292;5965.135055416962;6310.905336419957;6325.240971083476;6551.57414768041;6201.534884883629;6448.129502517147;6494.642794646293;6512.902306465407;6513.902291465632;6486.772962946297;6492.707828147744;6499.220093588752;6535.673216339188;6536.673166341688;3772.2832661794173;3873.9612603873884;5538.280023596947;5625.071863142576;5721.656700597978;20816.583668326548;21320.89339553308;21381.786182138134;21397;21406.785932140636;2278.498730279336;2293.564222797663;2309.6766452696634;2318.5826551220775;2386.85678859269;13176.802347964789;13632.386542605507;13782.65543361424;13818.309084545732;14438.783418248735;1905.1712505060343;1941;1965.636357273909;1978.980210197894;1983.3058429549687;72901;75867.62066189633;76373;80013.59993200055;82893;9988.350757200904;10155.898441015495;10416.114630256361;10492.947535262274;10834.729131771612;14116.294185290695;14208.857911420753;14248.358823852952;14252.429902803979;14268.85731142696;7437.628118594049;7649.502782319131;7737.419693523008;7885.802854928558;7890.289873911375;7415.88876166858;7451.3666338361845;7568.129665088585;7638.465307428538;7647.961760191163;4020.1356708307853;4325.091730736581;4328.718633288826;4363.105563359503;4524.841630542981;1721.5007647782004;1788.9676997489391;1803.8105998870192;1824.7810262768287;1878.474027272366;728.4973368375804;774.2166019831847;855.0978717453022;906.4923642760075;916.2624087609538;17418.17109203541;17773.911130444525;17890.91054544719;18154;18220;744.8324127071365;785;822.7449490657915;849.9277561407349;890.0921060518235;9272.72181834546;9770.902290977141;9870.65827657385;9872.457014864107;10076.949615251877;454449;455508;487296;489362;490654;85890;85892;86378;87182.56408718042;91567;883.7538873361328;888.8444522208588;892.0811564088999;904.1952662130709;904.7783293093103;16267.918660406622;16349.67300654004;16355.918220409298;16434.01395916249;16482.75275870887;40330.59669403268;40527.59472405238;40658.282658472504;42252.78873605612;42852;56128.43871561232;57417.138742918054;58033;58206;58242.7087864558;8293.33653307722;8306.709265175932;8554.743357699279;8658.177473140042;8805.42764720291;10450.529726162493;12902.612921612366;12930.159539629894;12983.35083245853;13081.542146025224;11212.83180752273;11351.37567433799;11497.19519633651;11517.193796434505;11700.590479333523;11297.096232301561;11297.943510282395;11382.829257561309;11638.53445862156;11726.88273117258;11348.54605815758;11384.14618903602;11567.363794991019;11660;11829.704257393634;8479.788005299917;8501.319894408556;8595.742127736177;8682.088380719933;8784.033756286932;10900.291481053706;11550.711232218926;11664.416779161178;11666.183367164216;11672.533098675958 03:00:05 INFO - PROCESS | 15721 | |3;mootools.html;1089.4661615808257;1168.474186616023;1193.6180422264877;1226.331649251158;1379.4689044717786;8027.678892844287;8401.159884011604;8487.278581320596;8634.179752923477;8638.395312328124;8180.345572354212;8323.62543685534;8329.042160151585;8357.791055223608;8361.289290410306;1921.730957665928;2166.079416248096;2167.8699278043327;2213.7454192767796;2223;2221.8444708870306;2225.7996780289773;2227.454273702945;2229.9888500557554;2231.2859884836857;2158.6330323844986;2182.476205710626;2189.0477642225605;2191.7698641642637;2194.2320187934256;1884.1992153334777;2052.363767232163;2066.059942726056;2073.450535608065;2150.817180539656;2083.0834432849497;2100.023489077571;2100.5693832764246;2102.2536999365157;2102.621528124937;8123.268905798447;8159.102498725136;8166;8173.427860049799;8186.386021048385;4603.424571928509;4772.379590653228;4806.903861922742;4807.759612019385;4830.879228019293;3077.9538306925415;3157.1002264354547;3193.9041828745176;3239.4330992076293;3252;1084.2838689083874;1100.0814320042693;1113.3041848844473;1138.1805100327751;1160.6053941659877;11519.942400287944;11535.538578456852;11560.94219528897;11565.653030409101;11583.768324633544;4118.794060296973;4202.642775364067;4230.978845105817;4325.394444777734;4329.653627709776;9714;9728.659496917573;9752.122308992224;9762.170215531618;9762.414255144571;4750.857474275708;4776;4785.019071090418;4785.042991401733;4794.616430685537;4066.9389959150635;4367.62875155609;4495.595396414338;4496.977515112403;4552.9772351138035;3562.5724913010085;3652.160003199279;3678.779273243614;3722.9441558376648;3747.6814470769746;1136.6590022993234;1177.8704342522315;1188.3404710385646;1189.714468527547;1204.3195594489086;861.642418396371;879.1691851200554;890.7817584691662;892.4645212872225;906.9682561110329;5808.854778630483;5889.528837692974;5917.615355001911;6002.789902353396;6082.878342433127;409.44111288092137;417.4322920827672;419.49660407511107;901.5987885391069;928.4243768863348;4246.917036155761;4313.223619748413;4328.783560821947;4392.516823149451;4431.180231657154;10125.493725313705;10210.387376757419;10252.538635761408;10345.586176553004;10361.481925903825;10258.333208341583;10261.9486902565;10262.076413122855;10262.384256944608;10275.383476991405;7665.195154508696;7983.2415920487465;7988.201179882081;7997.040355157535;8130.552819594979;5581.162825576196;5644.915326270191;5739.9139012915675;5784.797532086525;5792.275965504312;9088.409253398773;9319.254459643076;9326.06739326062;9460.243180545402;9464.053594640482;9368.4378937264;9516.238700903772;9536.952315238379;9550.570224340061;9567.330286879851;6577.14497115372;7235.8552828944175;7429.4799364044;7495.063117110361;7660.2722741339485;8501.787455313666;8533.27467165273;8590.1839325264;8596.39825212254;8612.956935215534;7475.588842613708;7663;7714.267144621476;7809.062912450315;7825.217478252129;7407.777766667009;7440.255974402517;7489.737859174903;7575.810604734926;7632.8473430532185;6783.660816959231;6808.38724514796;6830.795076147723;6846.554973926679;6852.6916288768125;4783.1390349737385;4980.377452818398;4997.475265097112;5054.848354549369;5094.2103973884105;5102.69383836971;5207.3230480038865;5234.18870075139;5260.526552610283;5264.710440925785 03:00:05 INFO - PROCESS | 15721 | |4;prototype.html;314.53605931251406;317.83790266963854;320.911749268951;320.9293955329828;322.5613166094113;5337.94489121688;5348.946510534894;5369.5704343652515;5392.245085688007;5406.513413792758;5276.314079169702;5277.551408130314;5279.70961597113;5280;5292.020976119411;3940.586238444958;3953.8220780064967;4076.1847630473876;4102.712810103294;4107.958920410802;4051.2910240707906;4079.4288799568085;4080.9183816323657;4090.6727461803134;4099.692523060768;3887.4751908492417;4043.898902527431;4049.7367671101433;4075.7962101894786;4112.239235741383;3940.6059394060653;3960.6237407446392;4035.636792688643;4071.470708807836;4072.4705788247634;3575.140926718092;3575.1955809942815;3597.3165098631175;3600.5859326177565;3603.243318903007;5133.948660513384;5145.485451454862;5150.3047088642925;5165.276861239429;5166.147585648364;4531.13908357411;4669.953300466986;4677.087967846272;4680.157571637138;4707.693999889996;5424.240606315119;5475.72621368934;5488.69812160331;5496.477834605706;5496.615236933416;3924.6860251180124;3937.251922134814;3947.131631041166;3986.123052928351;4009.797060881753;5438.450041738125;5770.711464426804;5800.477956983849;5801.448862358111;5803.361630220672;3987.6211759883345;3991.4012898064943;3993.7603743774885;3996.9200615987515;4000.879973600797;4008.518977722692;4026.57720939303;4043.211573743092;4045.309868937124;4047.736897101679;4482.296727243692;4711.67018308722;4726.692764970266;4729.69256998294;4734.573888350065;5626.409227031185;5646.745896434588;5658.462446067617;5659.726561523624;5666.858328541737;1383.266868559665;1394.2680092951282;1399.0276757653332;1418.4113592859055;1420.2401715082588;889.5241046040337;892.901780804111;898.3531857062904;898.5821592959174;942;5291.3121294231505;5332.33345831771;5336.946630533645;5398.946010539923;5399.595030372738;5682.886342273214;5687.459691329317;5694.914576281359;5717.599768016282;5718.542516598745;5121.61587880903;5222.97388513055;5317.7341132943975;5327.573794096463;5332.173513105475;2952.8994555716413;2962.7704502631595;2966.836823974702;2971.306355377414;3000.3099287164073;5708.1723150143;5731.824975879935;5736.873403994833;5751.798687045934;5769.394213607595;5455.390659755302;5731.914021289684;5732.856678582985;5752.252207213036;5792.580817699691;5776.249087618667;5835.124731290341;5844.298684157929;5890.584860207295;5913.970430147821;5494.532964698045;5686.914696279642;5704.172894930129;5734.684592347294;5756.856078598069;5587.69267690281;5651.4348565143155;5660.4905558498285;5719.370869204301;5757.683327417032;5860.472557469848;5936.703164841827;5956.285245770535;5959.880802384015;5969.626985793205;3917.8628747993685;4017.43755874172;4018.2566225248424;4019.1961607677995;4052.0275133968225;5718.79984200551;5737.827865164052;5773.336066352424;5774.451427114417;5794.62334948227;5396.21754845553;5507.476789704971;5548.306461692288;5568.638038527482;5623.465770751772;5508.283923090133;5533.916991245054;5574.191742197439;5585.832425027255;5612.663240205601;5251.973740131275;5443.292371991774;5455.690634247831;5479.506844384025;5499.9175012375645;5506.421825708403;5551.916721249266;5629.4104711833015;5630.634008789416;5645.971770141123;5414.864628384322;5432.158015507603;5464.781408743605;5498.130635583921;5543.334799824047 03:00:05 INFO - PROCESS | 15721 | |5;yui.html;686.7218776395558;712.9643517824107;740.637087826965;750.8685979953508;767.6200280860975;14330.641733956656;14891.702165956674;14920.776188357184;14940;14965.925170374147;14226.78659820101;14283.21442320672;14355.928220358883;14445.783313250284;14454.277286135677;635.4154178156084;732.3445516262955;748.3302444312337;773.6750564762785;777.1606664802028;751.969921203154;760.2663429790279;762.9122650895135;763.0423818108267;763.73651090374;803.9155888631698;804.1516200408566;805.4241217529466;805.5448671500612;805.6656487557657;666.1207206487438;776.3168411797582;796.8565658181525;797.5214871077366;801.4990630855715;578.7048605211372;583.0408977232471;583.629395333966;587.8589138606746;587.8706684529396;11736.941315293368;11758.941205293919;11769.882301176964;11774.411279435993;11782.057435405148;12728.61814145577;13288.667783305398;13330.86669133306;13351;13801.309934503235;11194.328340299526;12885.355732213351;12940.805887911689;13010.479580816851;13342.733145337039;4516.932246016312;4595.977020114911;4629.166749985001;4642.9071418571775;4648.907021859578;73785.63107184484;74089;74781.25218747798;74812.25187748107;78982.60508697477;10509.264351495474;10954.780904381867;11030.669079927615;11522;11566.669832969315;17145.571360716083;17491.30034798619;17500.299988000337;17508.737368939477;17509.12454377276;7752.6898924043535;8128.878066829002;8236.629351679188;8276.751697449086;8330.50016998982;4288.892777680583;4431.711938723973;4438.201123797748;4484.68607197493;4742.004179122423;3046.314579219658;3132.8746850126195;3135.608048993876;3136.2629782001213;3140.638826534978;558.8602849287678;568.624707692929;571.1860598646912;572.3160822816777;573.2032474859948;652.2727159217438;663;664.9202095748541;683.6889215407077;702.2906864067227;8842.19110509994;9195.402298850553;9235.953820230856;9469;9565;617.6880675258966;640.4204195203348;687.3676217879563;691.7993781803322;698.9161300643854;4375.7374557526655;4515.013394106582;4602.838900638461;4654.348391225231;4696.647751418657;113384.43307783408;114061.42969285266;114492;115070;118493;93783;98481.50759246158;99731.50134249282;100241;101611.4919425413;78868.60565697249;84894.57552712197;86775.56612217025;87018.56490717632;88388;8693.521856297964;8876.60055297526;8910.86633700508;8935.508547029976;9066.637334506546;49708.502914970384;49835.25247121369;51860.222096669335;52623;53562.196567052306;70698.29301707124;73699;73821.63089184735;75333;75471;10976;11007.394593297126;11073.723156921142;11195.88804111981;11223.71940701489;12358.691032724253;12439.129260952008;12528.937355313165;12585.307808070644;12622.431990560262;10973.945130274617;11210.103191744478;11223.326600404002;11267.774644507228;11544.884551154717;10428.113610343205;10572.577096916037;10597.25819192649;10603.46982650849;10613.946930265609;11172.832407513732;11183.832242516206;11270.492827822603;11521.366324852213;11544.884551154717;9374.203192728422;9516.95241523788;9674.70975870725;9969.252306076929;10006.749831254278;10104.292699510963;10371.688849334532;10421.478926053818;10427.270091093855;10430.58277668915 03:00:05 INFO - PROCESS | 15721 | __end_tp_report 03:00:05 INFO - PROCESS | 15721 | __start_cc_report 03:00:05 INFO - PROCESS | 15721 | _x_x_mozilla_cycle_collect,940 03:00:05 INFO - PROCESS | 15721 | __end_cc_report 03:00:05 INFO - PROCESS | 15721 | __startTimestamp1466676005135__endTimestamp 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | ------- Summary: start ------- 03:00:05 INFO - PROCESS | 15721 | Number of tests: 6 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | [#0] dojo.html Cycles:165 Average:5327.95 Median:5534.89 stddev:604.42 (10.9%) stddev-sans-first:580.50 03:00:05 INFO - PROCESS | 15721 | Values: 3102.1 3120.3 3144.8 3165.2 3173.3 5278.9 5346.2 5346.6 5456.3 5467.8 5259.3 5260.7 5428.9 5458.7 5509.8 4705.3 4816.6 4828.5 4839.5 5019.0 4964.0 4996.9 5010.4 5026.8 5067.4 4812.6 4821.4 4846.7 4862.6 4873.6 4769.1 4777.0 4778.1 4957.0 4966.3 4821.7 4849.2 4882.8 4899.6 4919.1 5280.8 5293.5 5402.6 5435.4 5440.0 5660.9 5763.3 5766.3 5767.2 5769.2 5768.7 5769.0 5833.4 5834.6 5836.1 5258.0 5335.3 5359.5 5444.2 5451.8 5899.9 5909.1 5909.9 5920.7 5925.0 5684.1 5691.3 5694.9 5696.1 5704.8 5602.7 5629.4 5670.8 5671.8 5761.9 5710.6 5710.9 5715.9 5716.5 5717.7 5673.0 5714.0 5717.8 5719.3 5725.2 4324.9 4329.5 4363.8 4422.9 4428.6 3870.7 3891.8 3996.1 4007.7 4008.4 5391.1 5395.1 5395.9 5404.4 5447.4 5729.9 5733.6 5734.4 5736.4 5767.9 5178.6 5287.5 5335.7 5389.9 5399.2 4763.3 4798.6 4803.5 4811.2 4835.2 5858.2 5908.6 5914.0 5917.9 5969.0 5578.4 5692.2 5719.7 5720.2 5730.5 5958.4 5981.3 5991.6 5993.9 5999.9 5692.9 5707.7 5711.4 5713.2 5713.4 5551.5 5711.7 5760.1 5771.8 5800.1 5672.7 5672.8 5673.3 5675.1 5682.8 5572.2 5572.8 5611.6 5617.2 5617.7 5385.9 5402.9 5452.2 5467.5 5492.1 5601.1 5681.4 5687.6 5694.9 5698.1 5382.4 5533.3 5534.9 5541.7 5542.8 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | [#1] ext.html Cycles:180 Average:52862.12 Median:35815.28 stddev:106944.91 (298.6%) stddev-sans-first:107172.79 03:00:05 INFO - PROCESS | 15721 | Values: 548.7 571.4 584.5 586.6 597.9 26729.5 27225.5 29138.1 38342.8 39987.0 33964.7 34091.0 34153.3 34191.3 34249.7 8458.2 8577.8 8597.5 8599.4 8602.0 8500.8 8583.7 8587.4 8592.3 8593.5 8630.9 8669.3 8673.3 8673.9 8674.0 8559.2 8591.1 8596.3 8600.4 8603.7 8330.6 8394.2 8487.3 8517.0 8544.0 35958.3 36061.3 36249.5 36309.6 36340.3 3339.5 3488.2 3497.5 3511.9 3617.4 28456.6 28620.3 28964.0 29318.4 29948.6 4037.3 4037.8 4051.9 4088.1 4152.6 344912.0 348511.0 348739.0 349492.0 350537.0 44234.0 44334.8 44501.6 44527.8 44562.0 43792.3 47837.3 47848.5 48301.0 48972.3 14185.4 14491.4 14514.1 14514.2 14526.5 11352.9 11434.5 11436.5 11436.9 11444.1 12259.3 13032.1 13249.7 13396.3 13415.8 5540.9 5610.7 5641.6 5673.6 5703.8 830.9 875.4 894.1 918.4 943.7 27916.3 28134.3 28299.0 28356.7 28374.7 945.3 955.9 964.9 1019.4 1029.6 14670.9 14826.3 15129.5 15139.0 15188.3 509586.0 509985.0 513089.0 513777.0 514245.0 46821.5 46963.8 46971.0 46984.1 46997.3 1060.4 1090.9 1117.0 1130.7 1139.3 27227.0 29397.0 29796.1 30011.5 30013.7 40685.4 40891.6 40995.8 41029.4 41475.4 318646.0 320587.0 320770.0 321076.0 321419.0 28516.3 34499.0 36154.5 36199.5 36991.4 40127.8 40245.2 40708.6 41042.0 41053.0 34124.0 34582.7 35117.8 35587.6 35606.0 34729.8 35178.8 35210.0 35474.5 35606.8 34514.5 35268.8 35404.6 35448.1 35672.3 31040.8 31574.8 31725.0 32375.0 32437.4 24375.9 27543.4 27641.6 27751.2 28050.9 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | [#2] jquery.html Cycles:180 Average:28076.34 Median:22387.63 stddev:78399.62 (350.2%) stddev-sans-first:78591.94 03:00:05 INFO - PROCESS | 15721 | Values: 365.0 367.9 373.9 382.8 387.4 16415.7 18068.0 18359.2 18744.3 18773.2 15758.5 16145.7 16354.2 16366.1 16376.8 5370.2 5587.7 5606.1 5626.5 5661.2 4117.0 5965.1 6310.9 6325.2 6551.6 6201.5 6448.1 6494.6 6512.9 6513.9 6486.8 6492.7 6499.2 6535.7 6536.7 3772.3 3874.0 5538.3 5625.1 5721.7 20816.6 21320.9 21381.8 21397.0 21406.8 2278.5 2293.6 2309.7 2318.6 2386.9 13176.8 13632.4 13782.7 13818.3 14438.8 1905.2 1941.0 1965.6 1979.0 1983.3 72901.0 75867.6 76373.0 80013.6 82893.0 9988.4 10155.9 10416.1 10492.9 10834.7 14116.3 14208.9 14248.4 14252.4 14268.9 7437.6 7649.5 7737.4 7885.8 7890.3 7415.9 7451.4 7568.1 7638.5 7648.0 4020.1 4325.1 4328.7 4363.1 4524.8 1721.5 1789.0 1803.8 1824.8 1878.5 728.5 774.2 855.1 906.5 916.3 17418.2 17773.9 17890.9 18154.0 18220.0 744.8 785.0 822.7 849.9 890.1 9272.7 9770.9 9870.7 9872.5 10076.9 454449.0 455508.0 487296.0 489362.0 490654.0 85890.0 85892.0 86378.0 87182.6 91567.0 883.8 888.8 892.1 904.2 904.8 16267.9 16349.7 16355.9 16434.0 16482.8 40330.6 40527.6 40658.3 42252.8 42852.0 56128.4 57417.1 58033.0 58206.0 58242.7 8293.3 8306.7 8554.7 8658.2 8805.4 10450.5 12902.6 12930.2 12983.4 13081.5 11212.8 11351.4 11497.2 11517.2 11700.6 11297.1 11297.9 11382.8 11638.5 11726.9 11348.5 11384.1 11567.4 11660.0 11829.7 8479.8 8501.3 8595.7 8682.1 8784.0 10900.3 11550.7 11664.4 11666.2 11672.5 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | [#3] mootools.html Cycles:180 Average:5509.11 Median:4800.76 stddev:3155.33 (65.7%) stddev-sans-first:3146.70 03:00:05 INFO - PROCESS | 15721 | Values: 1089.5 1168.5 1193.6 1226.3 1379.5 8027.7 8401.2 8487.3 8634.2 8638.4 8180.3 8323.6 8329.0 8357.8 8361.3 1921.7 2166.1 2167.9 2213.7 2223.0 2221.8 2225.8 2227.5 2230.0 2231.3 2158.6 2182.5 2189.0 2191.8 2194.2 1884.2 2052.4 2066.1 2073.5 2150.8 2083.1 2100.0 2100.6 2102.3 2102.6 8123.3 8159.1 8166.0 8173.4 8186.4 4603.4 4772.4 4806.9 4807.8 4830.9 3078.0 3157.1 3193.9 3239.4 3252.0 1084.3 1100.1 1113.3 1138.2 1160.6 11519.9 11535.5 11560.9 11565.7 11583.8 4118.8 4202.6 4231.0 4325.4 4329.7 9714.0 9728.7 9752.1 9762.2 9762.4 4750.9 4776.0 4785.0 4785.0 4794.6 4066.9 4367.6 4495.6 4497.0 4553.0 3562.6 3652.2 3678.8 3722.9 3747.7 1136.7 1177.9 1188.3 1189.7 1204.3 861.6 879.2 890.8 892.5 907.0 5808.9 5889.5 5917.6 6002.8 6082.9 409.4 417.4 419.5 901.6 928.4 4246.9 4313.2 4328.8 4392.5 4431.2 10125.5 10210.4 10252.5 10345.6 10361.5 10258.3 10261.9 10262.1 10262.4 10275.4 7665.2 7983.2 7988.2 7997.0 8130.6 5581.2 5644.9 5739.9 5784.8 5792.3 9088.4 9319.3 9326.1 9460.2 9464.1 9368.4 9516.2 9537.0 9550.6 9567.3 6577.1 7235.9 7429.5 7495.1 7660.3 8501.8 8533.3 8590.2 8596.4 8613.0 7475.6 7663.0 7714.3 7809.1 7825.2 7407.8 7440.3 7489.7 7575.8 7632.8 6783.7 6808.4 6830.8 6846.6 6852.7 4783.1 4980.4 4997.5 5054.8 5094.2 5102.7 5207.3 5234.2 5260.5 5264.7 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | [#4] prototype.html Cycles:180 Average:4654.56 Median:5359.26 stddev:1388.60 (25.9%) stddev-sans-first:1353.74 03:00:05 INFO - PROCESS | 15721 | Values: 314.5 317.8 320.9 320.9 322.6 5337.9 5348.9 5369.6 5392.2 5406.5 5276.3 5277.6 5279.7 5280.0 5292.0 3940.6 3953.8 4076.2 4102.7 4108.0 4051.3 4079.4 4080.9 4090.7 4099.7 3887.5 4043.9 4049.7 4075.8 4112.2 3940.6 3960.6 4035.6 4071.5 4072.5 3575.1 3575.2 3597.3 3600.6 3603.2 5133.9 5145.5 5150.3 5165.3 5166.1 4531.1 4670.0 4677.1 4680.2 4707.7 5424.2 5475.7 5488.7 5496.5 5496.6 3924.7 3937.3 3947.1 3986.1 4009.8 5438.5 5770.7 5800.5 5801.4 5803.4 3987.6 3991.4 3993.8 3996.9 4000.9 4008.5 4026.6 4043.2 4045.3 4047.7 4482.3 4711.7 4726.7 4729.7 4734.6 5626.4 5646.7 5658.5 5659.7 5666.9 1383.3 1394.3 1399.0 1418.4 1420.2 889.5 892.9 898.4 898.6 942.0 5291.3 5332.3 5336.9 5398.9 5399.6 5682.9 5687.5 5694.9 5717.6 5718.5 5121.6 5223.0 5317.7 5327.6 5332.2 2952.9 2962.8 2966.8 2971.3 3000.3 5708.2 5731.8 5736.9 5751.8 5769.4 5455.4 5731.9 5732.9 5752.3 5792.6 5776.2 5835.1 5844.3 5890.6 5914.0 5494.5 5686.9 5704.2 5734.7 5756.9 5587.7 5651.4 5660.5 5719.4 5757.7 5860.5 5936.7 5956.3 5959.9 5969.6 3917.9 4017.4 4018.3 4019.2 4052.0 5718.8 5737.8 5773.3 5774.5 5794.6 5396.2 5507.5 5548.3 5568.6 5623.5 5508.3 5533.9 5574.2 5585.8 5612.7 5252.0 5443.3 5455.7 5479.5 5499.9 5506.4 5551.9 5629.4 5630.6 5646.0 5414.9 5432.2 5464.8 5498.1 5543.3 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - PROCESS | 15721 | [#5] yui.html Cycles:180 Average:20035.97 Median:4675.50 stddev:29941.36 (640.4%) stddev-sans-first:29990.11 03:00:05 INFO - PROCESS | 15721 | Values: 686.7 713.0 740.6 750.9 767.6 14330.6 14891.7 14920.8 14940.0 14965.9 14226.8 14283.2 14355.9 14445.8 14454.3 635.4 732.3 748.3 773.7 777.2 752.0 760.3 762.9 763.0 763.7 803.9 804.2 805.4 805.5 805.7 666.1 776.3 796.9 797.5 801.5 578.7 583.0 583.6 587.9 587.9 11736.9 11758.9 11769.9 11774.4 11782.1 12728.6 13288.7 13330.9 13351.0 13801.3 11194.3 12885.4 12940.8 13010.5 13342.7 4516.9 4596.0 4629.2 4642.9 4648.9 73785.6 74089.0 74781.3 74812.3 78982.6 10509.3 10954.8 11030.7 11522.0 11566.7 17145.6 17491.3 17500.3 17508.7 17509.1 7752.7 8128.9 8236.6 8276.8 8330.5 4288.9 4431.7 4438.2 4484.7 4742.0 3046.3 3132.9 3135.6 3136.3 3140.6 558.9 568.6 571.2 572.3 573.2 652.3 663.0 664.9 683.7 702.3 8842.2 9195.4 9236.0 9469.0 9565.0 617.7 640.4 687.4 691.8 698.9 4375.7 4515.0 4602.8 4654.3 4696.6 113384.4 114061.4 114492.0 115070.0 118493.0 93783.0 98481.5 99731.5 100241.0 101611.5 78868.6 84894.6 86775.6 87018.6 88388.0 8693.5 8876.6 8910.9 8935.5 9066.6 49708.5 49835.3 51860.2 52623.0 53562.2 70698.3 73699.0 73821.6 75333.0 75471.0 10976.0 11007.4 11073.7 11195.9 11223.7 12358.7 12439.1 12528.9 12585.3 12622.4 10973.9 11210.1 11223.3 11267.8 11544.9 10428.1 10572.6 10597.3 10603.5 10613.9 11172.8 11183.8 11270.5 11521.4 11544.9 9374.2 9517.0 9674.7 9969.3 10006.7 10104.3 10371.7 10421.5 10427.3 10430.6 03:00:05 INFO - PROCESS | 15721 | -------- Summary: end -------- 03:00:05 INFO - PROCESS | 15721 | 03:00:05 INFO - TEST-INFO | 15721: exit 0 03:00:05 INFO - TEST-OK | dromaeo_css | took 1114536ms 03:00:05 INFO - TEST-START | kraken 03:00:05 INFO - operating with platform_type : linux_ 03:00:05 INFO - Initialising browser for kraken test... 03:00:05 INFO - TEST-INFO | started process 15903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb0D36m/profile http://localhost:46049/getInfo.html) 03:00:10 INFO - PROCESS | 15903 | __metrics Screen width/height:1600/1200 03:00:10 INFO - PROCESS | 15903 | colorDepth:24 03:00:10 INFO - PROCESS | 15903 | Browser inner width/height: 1024/697 03:00:10 INFO - PROCESS | 15903 | __metrics 03:00:10 INFO - PROCESS | 15903 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:11 INFO - TEST-INFO | 15903: exit 0 03:00:11 INFO - Browser initialized. 03:00:11 INFO - Running cycle 1/1 for kraken test... 03:00:11 INFO - TEST-INFO | started process 15986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb0D36m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:23 INFO - PROCESS | 15986 | RSS: Main: 173506560 03:00:23 INFO - PROCESS | 15986 | 03:00:26 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46049/tests/kraken/driver.html?testName=audio-beat-detection) 03:00:27 INFO - PROCESS | 15986 | RSS: Main: 232374272 03:00:27 INFO - PROCESS | 15986 | 03:00:29 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46049/tests/kraken/driver.html?testName=audio-dft) 03:00:30 INFO - PROCESS | 15986 | RSS: Main: 221245440 03:00:30 INFO - PROCESS | 15986 | 03:00:33 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46049/tests/kraken/driver.html?testName=audio-fft) 03:00:34 INFO - PROCESS | 15986 | RSS: Main: 286920704 03:00:34 INFO - PROCESS | 15986 | 03:00:36 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46049/tests/kraken/driver.html?testName=audio-oscillator) 03:00:36 INFO - PROCESS | 15986 | RSS: Main: 198410240 03:00:36 INFO - PROCESS | 15986 | 03:00:39 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:00:39 INFO - PROCESS | 15986 | RSS: Main: 202117120 03:00:39 INFO - PROCESS | 15986 | 03:00:42 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46049/tests/kraken/driver.html?testName=imaging-darkroom) 03:00:43 INFO - PROCESS | 15986 | RSS: Main: 236617728 03:00:43 INFO - PROCESS | 15986 | 03:00:46 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46049/tests/kraken/driver.html?testName=imaging-desaturate) 03:00:47 INFO - PROCESS | 15986 | RSS: Main: 238317568 03:00:47 INFO - PROCESS | 15986 | 03:00:50 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46049/tests/kraken/driver.html?testName=json-parse-financial) 03:00:50 INFO - PROCESS | 15986 | RSS: Main: 238022656 03:00:50 INFO - PROCESS | 15986 | 03:00:52 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:00:52 INFO - PROCESS | 15986 | RSS: Main: 225562624 03:00:52 INFO - PROCESS | 15986 | 03:00:54 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:00:55 INFO - PROCESS | 15986 | RSS: Main: 230633472 03:00:55 INFO - PROCESS | 15986 | 03:00:57 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:00:58 INFO - PROCESS | 15986 | RSS: Main: 235356160 03:00:58 INFO - PROCESS | 15986 | 03:01:00 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:01 INFO - PROCESS | 15986 | RSS: Main: 250720256 03:01:01 INFO - PROCESS | 15986 | 03:01:03 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:04 INFO - PROCESS | 15986 | RSS: Main: 245788672 03:01:04 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:46049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46049/tests/kraken/driver.html?testName=ai-astar) 03:01:06 INFO - PROCESS | 15986 | RSS: Main: 288321536 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | __start_tp_report 03:01:06 INFO - PROCESS | 15986 | _x_x_mozilla_page_load 03:01:06 INFO - PROCESS | 15986 | _x_x_mozilla_page_load_details 03:01:06 INFO - PROCESS | 15986 | |i|pagename|runs| 03:01:06 INFO - PROCESS | 15986 | |0;ai-astar;101;110;110;111;113;111;110;110;110;110 03:01:06 INFO - PROCESS | 15986 | |1;audio-beat-detection;152;132;134;184;129;127;156;127;181;125 03:01:06 INFO - PROCESS | 15986 | |2;audio-dft;161;161;162;161;160;161;161;160;163;161 03:01:06 INFO - PROCESS | 15986 | |3;audio-fft;74;74;75;123;75;74;73;74;96;76 03:01:06 INFO - PROCESS | 15986 | |4;audio-oscillator;85;85;115;86;85;86;125;85;85;132 03:01:06 INFO - PROCESS | 15986 | |5;imaging-gaussian-blur;118;118;117;117;117;116;117;118;117;117 03:01:06 INFO - PROCESS | 15986 | |6;imaging-darkroom;147;147;146;146;147;146;201;146;147;146 03:01:06 INFO - PROCESS | 15986 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;95 03:01:06 INFO - PROCESS | 15986 | |8;json-parse-financial;53;52;54;52;53;54;52;54;52;54 03:01:06 INFO - PROCESS | 15986 | |9;json-stringify-tinderbox;61;61;61;61;61;61;62;61;61;61 03:01:06 INFO - PROCESS | 15986 | |10;stanford-crypto-aes;80;85;82;79;84;84;80;83;157;80 03:01:06 INFO - PROCESS | 15986 | |11;stanford-crypto-ccm;124;131;120;119;130;119;119;126;122;127 03:01:06 INFO - PROCESS | 15986 | |12;stanford-crypto-pbkdf2;159;158;161;162;160;166;156;159;157;165 03:01:06 INFO - PROCESS | 15986 | |13;stanford-crypto-sha256-iterative;64;64;62;63;63;62;63;61;63;62 03:01:06 INFO - PROCESS | 15986 | __end_tp_report 03:01:06 INFO - PROCESS | 15986 | __start_cc_report 03:01:06 INFO - PROCESS | 15986 | _x_x_mozilla_cycle_collect,1710 03:01:06 INFO - PROCESS | 15986 | __end_cc_report 03:01:06 INFO - PROCESS | 15986 | __startTimestamp1466676066497__endTimestamp 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | ------- Summary: start ------- 03:01:06 INFO - PROCESS | 15986 | Number of tests: 14 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:3.17 (2.9%) stddev-sans-first:1.01 03:01:06 INFO - PROCESS | 15986 | Values: 101.0 110.0 110.0 111.0 113.0 111.0 110.0 110.0 110.0 110.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:143.00 stddev:22.56 (15.8%) stddev-sans-first:23.77 03:01:06 INFO - PROCESS | 15986 | Values: 152.0 132.0 134.0 184.0 129.0 127.0 156.0 127.0 181.0 125.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 03:01:06 INFO - PROCESS | 15986 | Values: 161.0 161.0 162.0 161.0 160.0 161.0 161.0 160.0 163.0 161.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.50 stddev:16.14 (21.7%) stddev-sans-first:16.90 03:01:06 INFO - PROCESS | 15986 | Values: 74.0 74.0 75.0 123.0 75.0 74.0 73.0 74.0 96.0 76.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:19.13 (22.5%) stddev-sans-first:19.80 03:01:06 INFO - PROCESS | 15986 | Values: 85.0 85.0 115.0 86.0 85.0 86.0 125.0 85.0 85.0 132.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 03:01:06 INFO - PROCESS | 15986 | Values: 118.0 118.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:147.00 stddev:17.26 (11.7%) stddev-sans-first:18.21 03:01:06 INFO - PROCESS | 15986 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 201.0 146.0 147.0 146.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:01:06 INFO - PROCESS | 15986 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.50 stddev:0.94 (1.8%) stddev-sans-first:1.00 03:01:06 INFO - PROCESS | 15986 | Values: 53.0 52.0 54.0 52.0 53.0 54.0 52.0 54.0 52.0 54.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 03:01:06 INFO - PROCESS | 15986 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:82.50 stddev:23.84 (28.9%) stddev-sans-first:25.05 03:01:06 INFO - PROCESS | 15986 | Values: 80.0 85.0 82.0 79.0 84.0 84.0 80.0 83.0 157.0 80.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:125.00 stddev:4.62 (3.7%) stddev-sans-first:4.90 03:01:06 INFO - PROCESS | 15986 | Values: 124.0 131.0 120.0 119.0 130.0 119.0 119.0 126.0 122.0 127.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:3.27 (2.0%) stddev-sans-first:3.43 03:01:06 INFO - PROCESS | 15986 | Values: 159.0 158.0 161.0 162.0 160.0 166.0 156.0 159.0 157.0 165.0 03:01:06 INFO - PROCESS | 15986 | 03:01:06 INFO - PROCESS | 15986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:0.88 03:01:06 INFO - PROCESS | 15986 | Values: 64.0 64.0 62.0 63.0 63.0 62.0 63.0 61.0 63.0 62.0 03:01:06 INFO - PROCESS | 15986 | -------- Summary: end -------- 03:01:06 INFO - PROCESS | 15986 | 03:01:07 INFO - TEST-INFO | 15986: exit 0 03:01:07 INFO - TEST-OK | kraken | took 61571ms 03:01:07 INFO - SUITE-END | took 1176s 03:01:07 INFO - Completed test suite (00:19:36) 03:01:07 INFO - javascript benchmark 03:01:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.1314032071023, 3120.2511397264648, 3144.842757862107, 3165.224519992599, 3173.30187358781, 5278.947210527894, 5346.198070289449, 5346.572274218063, 5456.345238571372, 5467.753951072196, 5259.263703081571, 5260.658057226277, 5428.864278393042, 5458.699771512565, 5509.752061157247, 4705.341252224691, 4816.63875209359, 4828.46886842447, 4839.516048395168, 5019.046381187581, 4964.0, 4996.850094497171, 5010.423801262847, 5026.849194524152, 5067.417247016603, 4812.639052071091, 4821.421429428456, 4846.684965477232, 4862.562369386755, 4873.561379475864, 4769.070031343889, 4776.952230477686, 4778.068276686047, 4957.0, 4966.2798894160505, 4821.68659037165, 4849.151398505247, 4882.804687812483, 4899.55903968641, 4919.08996835583, 5280.788768449257, 5293.497117773805, 5402.567794576425, 5435.374931882845, 5440.020796256672, 5660.85847853807, 5763.308402991626, 5766.279215098113, 5767.221425107598, 5769.163471296681, 5768.74040668171, 5768.971155144198, 5833.38749431312, 5834.5915785895, 5836.095405212199, 5258.0, 5335.279737235501, 5359.544438722674, 5444.210589464545, 5451.836444906659, 5899.852503687443, 5909.054551271776, 5909.852253693692, 5920.703964801829, 5924.970375148183, 5684.118961560965, 5691.345495268014, 5694.9430505695245, 5696.11710184922, 5704.80033198836, 5602.719864006865, 5629.352624448159, 5670.7731690732735, 5671.829845104653, 5761.942380576141, 5710.571707121982, 5710.942890571124, 5715.942840571624, 5716.485516303553, 5717.656940583578, 5673.0, 5714.0, 5717.828465146053, 5719.3422756382715, 5725.227094342294, 4324.913501729948, 4329.545397733255, 4363.825446982085, 4422.867313980586, 4428.623566996777, 3870.670992965573, 3891.7664940103687, 3996.080901392696, 4007.699422543321, 4008.4388185654034, 5391.110466773017, 5395.082835917903, 5395.946040539623, 5404.405515393303, 5447.428020057916, 5729.914051289234, 5733.569982251348, 5734.397888221677, 5736.368999410061, 5767.942320576824, 5178.559822415062, 5287.471252874681, 5335.67985920846, 5389.865253368697, 5399.217113518518, 4763.261694437368, 4798.592119669797, 4803.543663351976, 4811.158047341702, 4835.202191638411, 5858.209141765892, 5908.645481271137, 5914.02418600926, 5917.881642367129, 5969.0, 5578.414266502121, 5692.203091567101, 5719.714014299351, 5720.17057526648, 5730.541556675373, 5958.433948774859, 5981.252343457068, 5991.64050156992, 5993.940060599338, 5999.91000135007, 5692.914606280826, 5707.714614269187, 5711.400302968294, 5713.22871412354, 5713.400092990342, 5551.528120109674, 5711.714414279352, 5760.0783874579865, 5771.826845194651, 5800.100984347433, 5672.659640421588, 5672.829815105553, 5673.319201695823, 5675.091985282335, 5682.829515114553, 5572.247746554163, 5572.804951826666, 5611.607187496836, 5617.241672374177, 5617.691026993554, 5385.919211211756, 5402.891942161214, 5452.2094296327605, 5467.507924286833, 5492.148716948879, 5601.075822489406, 5681.431856814285, 5687.601867869375, 5694.914576281276, 5698.116791897262, 5382.3541175059245, 5533.253010843485, 5534.889302213853, 5541.667499950016, 5542.806001789918], "value": 5287.575404784182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6899901555621, 571.4456976732567, 584.4710536964047, 586.6069733278703, 597.8684689368338, 26729.465410691773, 27225.455490890196, 29138.12585622432, 38342.8082859586, 39987.0, 33964.66035339646, 34091.0, 34153.316933661314, 34191.31617367651, 34249.65750342496, 8458.196471335228, 8577.785555361104, 8597.484150950962, 8599.398042137052, 8601.95699021507, 8500.78748031298, 8583.699570515033, 8587.441816281953, 8592.312614990817, 8593.484390936565, 8630.870536941951, 8669.306455483546, 8673.306135509145, 8673.869891951594, 8673.95663021684, 8559.22966932976, 8591.05498395176, 8596.312295016383, 8600.440971336842, 8603.698870539532, 8330.62512186953, 8394.202550757669, 8487.278581320596, 8516.957415212946, 8543.95728021362, 35958.280834383426, 36061.27877442436, 36249.45625815615, 36309.63690363089, 36340.27319453596, 3339.5491608632765, 3488.232588830453, 3497.545319108525, 3511.877084302063, 3617.403128483797, 28456.573151402747, 28620.284492887637, 28964.0, 29318.41363172746, 29948.550771738443, 4037.253108174997, 4037.7981100944835, 4051.898702532431, 4088.1414902870433, 4152.565991161364, 344912.0, 348511.0, 348739.0, 349492.0, 350537.0, 44234.0, 44334.778326108164, 44501.55498445039, 44527.777361113636, 44562.0, 43792.343114853305, 47837.28244076342, 47848.52151478441, 48301.0, 48972.26541601879, 14185.432582696783, 14491.420343186366, 14514.056586321854, 14514.201718905562, 14526.491572794901, 11352.886471135349, 11434.542618295174, 11436.485358158903, 11436.94281528587, 11444.084473242287, 12259.264444133381, 13032.087753857328, 13249.668758280928, 13396.330183490787, 13415.798763018562, 5540.9168862467095, 5610.663360198401, 5641.605087643826, 5673.574481913873, 5703.828885133453, 830.8836762853206, 875.4484674654926, 894.0790985285166, 918.3663272342062, 943.712167788831, 27916.30209244785, 28134.29664258369, 28299.0, 28356.71643283541, 28374.71625283762, 945.333539854401, 955.9378640388353, 964.9228061755043, 1019.4189312092036, 1029.552144817007, 14670.926645366704, 14826.33281502335, 15129.47046853355, 15139.0, 15188.316525756367, 509586.0, 509985.0, 513089.0, 513777.0, 514245.0, 46821.5317846824, 46963.76518117456, 46971.0, 46984.06031879343, 46997.29504057442, 1060.411471633251, 1090.8581884354983, 1116.9720756980978, 1130.6947124276398, 1139.2765593847967, 27227.0, 29397.0, 29796.10611681653, 30011.549826753053, 30013.699863001963, 40685.38971915483, 40891.59108408878, 40995.79502102471, 41029.38455923223, 41475.37786933138, 318646.0, 320587.0, 320770.0, 321076.0, 321419.0, 28516.287092822844, 34498.9650310481, 36154.4576831353, 36199.45700814542, 36991.44512832256, 40127.79936100301, 40245.1950960985, 40708.59291407166, 41042.0, 41053.0, 34124.0, 34582.654173457944, 35117.824410878806, 35587.644123558435, 35606.0, 34729.82635086808, 35178.82410587931, 35210.0, 35474.467882982295, 35606.821965890005, 34514.48228276628, 35268.823655881555, 35404.64595354014, 35448.113797155274, 35672.28655426929, 31040.844795775876, 31574.842125789222, 31725.0, 32375.0, 32437.35125297528, 24375.878120609283, 27543.449131017667, 27641.585376219777, 27751.167464976083, 28050.859745701142], "value": 17664.641624490694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.005246328813, 367.8528588564574, 373.9046543131501, 382.7971175277104, 387.42274011722526, 16415.67168656626, 18068.0, 18359.173837177324, 18744.343947961825, 18773.2490700372, 15758.527244182693, 16145.677086458292, 16354.182290885468, 16366.099864507447, 16376.83623163768, 5370.221317908901, 5587.720613969285, 5606.074997625407, 5626.521745651625, 5661.207430959669, 4116.97941510292, 5965.135055416962, 6310.905336419957, 6325.240971083476, 6551.57414768041, 6201.534884883629, 6448.129502517147, 6494.642794646293, 6512.902306465407, 6513.902291465632, 6486.772962946297, 6492.707828147744, 6499.220093588752, 6535.673216339188, 6536.673166341688, 3772.2832661794173, 3873.9612603873884, 5538.280023596947, 5625.071863142576, 5721.656700597978, 20816.583668326548, 21320.89339553308, 21381.786182138134, 21397.0, 21406.785932140636, 2278.498730279336, 2293.564222797663, 2309.6766452696634, 2318.5826551220775, 2386.85678859269, 13176.802347964789, 13632.386542605507, 13782.65543361424, 13818.309084545732, 14438.783418248735, 1905.1712505060343, 1941.0, 1965.636357273909, 1978.980210197894, 1983.3058429549687, 72901.0, 75867.62066189633, 76373.0, 80013.59993200055, 82893.0, 9988.350757200904, 10155.898441015495, 10416.114630256361, 10492.947535262274, 10834.729131771612, 14116.294185290695, 14208.857911420753, 14248.358823852952, 14252.429902803979, 14268.85731142696, 7437.628118594049, 7649.502782319131, 7737.419693523008, 7885.802854928558, 7890.289873911375, 7415.88876166858, 7451.3666338361845, 7568.129665088585, 7638.465307428538, 7647.961760191163, 4020.1356708307853, 4325.091730736581, 4328.718633288826, 4363.105563359503, 4524.841630542981, 1721.5007647782004, 1788.9676997489391, 1803.8105998870192, 1824.7810262768287, 1878.474027272366, 728.4973368375804, 774.2166019831847, 855.0978717453022, 906.4923642760075, 916.2624087609538, 17418.17109203541, 17773.911130444525, 17890.91054544719, 18154.0, 18220.0, 744.8324127071365, 785.0, 822.7449490657915, 849.9277561407349, 890.0921060518235, 9272.72181834546, 9770.902290977141, 9870.65827657385, 9872.457014864107, 10076.949615251877, 454449.0, 455508.0, 487296.0, 489362.0, 490654.0, 85890.0, 85892.0, 86378.0, 87182.56408718042, 91567.0, 883.7538873361328, 888.8444522208588, 892.0811564088999, 904.1952662130709, 904.7783293093103, 16267.918660406622, 16349.67300654004, 16355.918220409298, 16434.01395916249, 16482.75275870887, 40330.59669403268, 40527.59472405238, 40658.282658472504, 42252.78873605612, 42852.0, 56128.43871561232, 57417.138742918054, 58033.0, 58206.0, 58242.7087864558, 8293.33653307722, 8306.709265175932, 8554.743357699279, 8658.177473140042, 8805.42764720291, 10450.529726162493, 12902.612921612366, 12930.159539629894, 12983.35083245853, 13081.542146025224, 11212.83180752273, 11351.37567433799, 11497.19519633651, 11517.193796434505, 11700.590479333523, 11297.096232301561, 11297.943510282395, 11382.829257561309, 11638.53445862156, 11726.88273117258, 11348.54605815758, 11384.14618903602, 11567.363794991019, 11660.0, 11829.704257393634, 8479.788005299917, 8501.319894408556, 8595.742127736177, 8682.088380719933, 8784.033756286932, 10900.291481053706, 11550.711232218926, 11664.416779161178, 11666.183367164216, 11672.533098675958], "value": 8883.998470447672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1089.4661615808257, 1168.474186616023, 1193.6180422264877, 1226.331649251158, 1379.4689044717786, 8027.678892844287, 8401.159884011604, 8487.278581320596, 8634.179752923477, 8638.395312328124, 8180.345572354212, 8323.62543685534, 8329.042160151585, 8357.791055223608, 8361.289290410306, 1921.730957665928, 2166.079416248096, 2167.8699278043327, 2213.7454192767796, 2223.0, 2221.8444708870306, 2225.7996780289773, 2227.454273702945, 2229.9888500557554, 2231.2859884836857, 2158.6330323844986, 2182.476205710626, 2189.0477642225605, 2191.7698641642637, 2194.2320187934256, 1884.1992153334777, 2052.363767232163, 2066.059942726056, 2073.450535608065, 2150.817180539656, 2083.0834432849497, 2100.023489077571, 2100.5693832764246, 2102.2536999365157, 2102.621528124937, 8123.268905798447, 8159.102498725136, 8166.0, 8173.427860049799, 8186.386021048385, 4603.424571928509, 4772.379590653228, 4806.903861922742, 4807.759612019385, 4830.879228019293, 3077.9538306925415, 3157.1002264354547, 3193.9041828745176, 3239.4330992076293, 3252.0, 1084.2838689083874, 1100.0814320042693, 1113.3041848844473, 1138.1805100327751, 1160.6053941659877, 11519.942400287944, 11535.538578456852, 11560.94219528897, 11565.653030409101, 11583.768324633544, 4118.794060296973, 4202.642775364067, 4230.978845105817, 4325.394444777734, 4329.653627709776, 9714.0, 9728.659496917573, 9752.122308992224, 9762.170215531618, 9762.414255144571, 4750.857474275708, 4776.0, 4785.019071090418, 4785.042991401733, 4794.616430685537, 4066.9389959150635, 4367.62875155609, 4495.595396414338, 4496.977515112403, 4552.9772351138035, 3562.5724913010085, 3652.160003199279, 3678.779273243614, 3722.9441558376648, 3747.6814470769746, 1136.6590022993234, 1177.8704342522315, 1188.3404710385646, 1189.714468527547, 1204.3195594489086, 861.642418396371, 879.1691851200554, 890.7817584691662, 892.4645212872225, 906.9682561110329, 5808.854778630483, 5889.528837692974, 5917.615355001911, 6002.789902353396, 6082.878342433127, 409.44111288092137, 417.4322920827672, 419.49660407511107, 901.5987885391069, 928.4243768863348, 4246.917036155761, 4313.223619748413, 4328.783560821947, 4392.516823149451, 4431.180231657154, 10125.493725313705, 10210.387376757419, 10252.538635761408, 10345.586176553004, 10361.481925903825, 10258.333208341583, 10261.9486902565, 10262.076413122855, 10262.384256944608, 10275.383476991405, 7665.195154508696, 7983.2415920487465, 7988.201179882081, 7997.040355157535, 8130.552819594979, 5581.162825576196, 5644.915326270191, 5739.9139012915675, 5784.797532086525, 5792.275965504312, 9088.409253398773, 9319.254459643076, 9326.06739326062, 9460.243180545402, 9464.053594640482, 9368.4378937264, 9516.238700903772, 9536.952315238379, 9550.570224340061, 9567.330286879851, 6577.14497115372, 7235.8552828944175, 7429.4799364044, 7495.063117110361, 7660.2722741339485, 8501.787455313666, 8533.27467165273, 8590.1839325264, 8596.39825212254, 8612.956935215534, 7475.588842613708, 7663.0, 7714.267144621476, 7809.062912450315, 7825.217478252129, 7407.777766667009, 7440.255974402517, 7489.737859174903, 7575.810604734926, 7632.8473430532185, 6783.660816959231, 6808.38724514796, 6830.795076147723, 6846.554973926679, 6852.6916288768125, 4783.1390349737385, 4980.377452818398, 4997.475265097112, 5054.848354549369, 5094.2103973884105, 5102.69383836971, 5207.3230480038865, 5234.18870075139, 5260.526552610283, 5264.710440925785], "value": 4337.6122416379885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.53605931251406, 317.83790266963854, 320.911749268951, 320.9293955329828, 322.5613166094113, 5337.94489121688, 5348.946510534894, 5369.5704343652515, 5392.245085688007, 5406.513413792758, 5276.314079169702, 5277.551408130314, 5279.70961597113, 5280.0, 5292.020976119411, 3940.586238444958, 3953.8220780064967, 4076.1847630473876, 4102.712810103294, 4107.958920410802, 4051.2910240707906, 4079.4288799568085, 4080.9183816323657, 4090.6727461803134, 4099.692523060768, 3887.4751908492417, 4043.898902527431, 4049.7367671101433, 4075.7962101894786, 4112.239235741383, 3940.6059394060653, 3960.6237407446392, 4035.636792688643, 4071.470708807836, 4072.4705788247634, 3575.140926718092, 3575.1955809942815, 3597.3165098631175, 3600.5859326177565, 3603.243318903007, 5133.948660513384, 5145.485451454862, 5150.3047088642925, 5165.276861239429, 5166.147585648364, 4531.13908357411, 4669.953300466986, 4677.087967846272, 4680.157571637138, 4707.693999889996, 5424.240606315119, 5475.72621368934, 5488.69812160331, 5496.477834605706, 5496.615236933416, 3924.6860251180124, 3937.251922134814, 3947.131631041166, 3986.123052928351, 4009.797060881753, 5438.450041738125, 5770.711464426804, 5800.477956983849, 5801.448862358111, 5803.361630220672, 3987.6211759883345, 3991.4012898064943, 3993.7603743774885, 3996.9200615987515, 4000.879973600797, 4008.518977722692, 4026.57720939303, 4043.211573743092, 4045.309868937124, 4047.736897101679, 4482.296727243692, 4711.67018308722, 4726.692764970266, 4729.69256998294, 4734.573888350065, 5626.409227031185, 5646.745896434588, 5658.462446067617, 5659.726561523624, 5666.858328541737, 1383.266868559665, 1394.2680092951282, 1399.0276757653332, 1418.4113592859055, 1420.2401715082588, 889.5241046040337, 892.901780804111, 898.3531857062904, 898.5821592959174, 942.0, 5291.3121294231505, 5332.33345831771, 5336.946630533645, 5398.946010539923, 5399.595030372738, 5682.886342273214, 5687.459691329317, 5694.914576281359, 5717.599768016282, 5718.542516598745, 5121.61587880903, 5222.97388513055, 5317.7341132943975, 5327.573794096463, 5332.173513105475, 2952.8994555716413, 2962.7704502631595, 2966.836823974702, 2971.306355377414, 3000.3099287164073, 5708.1723150143, 5731.824975879935, 5736.873403994833, 5751.798687045934, 5769.394213607595, 5455.390659755302, 5731.914021289684, 5732.856678582985, 5752.252207213036, 5792.580817699691, 5776.249087618667, 5835.124731290341, 5844.298684157929, 5890.584860207295, 5913.970430147821, 5494.532964698045, 5686.914696279642, 5704.172894930129, 5734.684592347294, 5756.856078598069, 5587.69267690281, 5651.4348565143155, 5660.4905558498285, 5719.370869204301, 5757.683327417032, 5860.472557469848, 5936.703164841827, 5956.285245770535, 5959.880802384015, 5969.626985793205, 3917.8628747993685, 4017.43755874172, 4018.2566225248424, 4019.1961607677995, 4052.0275133968225, 5718.79984200551, 5737.827865164052, 5773.336066352424, 5774.451427114417, 5794.62334948227, 5396.21754845553, 5507.476789704971, 5548.306461692288, 5568.638038527482, 5623.465770751772, 5508.283923090133, 5533.916991245054, 5574.191742197439, 5585.832425027255, 5612.663240205601, 5251.973740131275, 5443.292371991774, 5455.690634247831, 5479.506844384025, 5499.9175012375645, 5506.421825708403, 5551.916721249266, 5629.4104711833015, 5630.634008789416, 5645.971770141123, 5414.864628384322, 5432.158015507603, 5464.781408743605, 5498.130635583921, 5543.334799824047], "value": 4205.902955665455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.7218776395558, 712.9643517824107, 740.637087826965, 750.8685979953508, 767.6200280860975, 14330.641733956656, 14891.702165956674, 14920.776188357184, 14940.0, 14965.925170374147, 14226.78659820101, 14283.21442320672, 14355.928220358883, 14445.783313250284, 14454.277286135677, 635.4154178156084, 732.3445516262955, 748.3302444312337, 773.6750564762785, 777.1606664802028, 751.969921203154, 760.2663429790279, 762.9122650895135, 763.0423818108267, 763.73651090374, 803.9155888631698, 804.1516200408566, 805.4241217529466, 805.5448671500612, 805.6656487557657, 666.1207206487438, 776.3168411797582, 796.8565658181525, 797.5214871077366, 801.4990630855715, 578.7048605211372, 583.0408977232471, 583.629395333966, 587.8589138606746, 587.8706684529396, 11736.941315293368, 11758.941205293919, 11769.882301176964, 11774.411279435993, 11782.057435405148, 12728.61814145577, 13288.667783305398, 13330.86669133306, 13351.0, 13801.309934503235, 11194.328340299526, 12885.355732213351, 12940.805887911689, 13010.479580816851, 13342.733145337039, 4516.932246016312, 4595.977020114911, 4629.166749985001, 4642.9071418571775, 4648.907021859578, 73785.63107184484, 74089.0, 74781.25218747798, 74812.25187748107, 78982.60508697477, 10509.264351495474, 10954.780904381867, 11030.669079927615, 11522.0, 11566.669832969315, 17145.571360716083, 17491.30034798619, 17500.299988000337, 17508.737368939477, 17509.12454377276, 7752.6898924043535, 8128.878066829002, 8236.629351679188, 8276.751697449086, 8330.50016998982, 4288.892777680583, 4431.711938723973, 4438.201123797748, 4484.68607197493, 4742.004179122423, 3046.314579219658, 3132.8746850126195, 3135.608048993876, 3136.2629782001213, 3140.638826534978, 558.8602849287678, 568.624707692929, 571.1860598646912, 572.3160822816777, 573.2032474859948, 652.2727159217438, 663.0, 664.9202095748541, 683.6889215407077, 702.2906864067227, 8842.19110509994, 9195.402298850553, 9235.953820230856, 9469.0, 9565.0, 617.6880675258966, 640.4204195203348, 687.3676217879563, 691.7993781803322, 698.9161300643854, 4375.7374557526655, 4515.013394106582, 4602.838900638461, 4654.348391225231, 4696.647751418657, 113384.43307783408, 114061.42969285266, 114492.0, 115070.0, 118493.0, 93783.0, 98481.50759246158, 99731.50134249282, 100241.0, 101611.4919425413, 78868.60565697249, 84894.57552712197, 86775.56612217025, 87018.56490717632, 88388.0, 8693.521856297964, 8876.60055297526, 8910.86633700508, 8935.508547029976, 9066.637334506546, 49708.502914970384, 49835.25247121369, 51860.222096669335, 52623.0, 53562.196567052306, 70698.29301707124, 73699.0, 73821.63089184735, 75333.0, 75471.0, 10976.0, 11007.394593297126, 11073.723156921142, 11195.88804111981, 11223.71940701489, 12358.691032724253, 12439.129260952008, 12528.937355313165, 12585.307808070644, 12622.431990560262, 10973.945130274617, 11210.103191744478, 11223.326600404002, 11267.774644507228, 11544.884551154717, 10428.113610343205, 10572.577096916037, 10597.25819192649, 10603.46982650849, 10613.946930265609, 11172.832407513732, 11183.832242516206, 11270.492827822603, 11521.366324852213, 11544.884551154717, 9374.203192728422, 9516.95241523788, 9674.70975870725, 9969.252306076929, 10006.749831254278, 10104.292699510963, 10371.688849334532, 10421.478926053818, 10427.270091093855, 10430.58277668915], "value": 7036.071715572562, "unit": "score"}], "name": "dromaeo_css", "value": 6885.075769337224, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 111.0, 113.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 132.0, 134.0, 184.0, 129.0, 127.0, 156.0, 127.0, 181.0, 125.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 163.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 123.0, 75.0, 74.0, 73.0, 74.0, 96.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 86.0, 85.0, 86.0, 125.0, 85.0, 85.0, 132.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 201.0, 146.0, 147.0, 146.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 52.0, 53.0, 54.0, 52.0, 54.0, 52.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 82.0, 79.0, 84.0, 84.0, 80.0, 83.0, 157.0, 80.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 120.0, 119.0, 130.0, 119.0, 119.0, 126.0, 122.0, 127.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 161.0, 162.0, 160.0, 166.0, 156.0, 159.0, 157.0, 165.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 63.0, 63.0, 62.0, 63.0, 61.0, 63.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1507.8, "alertThreshold": 2.0}]} 03:01:07 INFO - Return code: 0 03:01:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:01:07 INFO - # TBPL SUCCESS # 03:01:07 INFO - Running post-action listener: _resource_record_post_action 03:01:07 INFO - ##### 03:01:07 INFO - ##### Finished run-tests step (success) 03:01:07 INFO - ##### 03:01:07 INFO - Running post-run listener: _resource_record_post_run 03:01:07 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 73728; Write bytes: 407150592; Read time: 16; Write time: 314704 03:01:07 INFO - TinderboxPrint: CPU usage
13.1% 03:01:07 INFO - TinderboxPrint: I/O read bytes / time
73,728 / 16 03:01:07 INFO - TinderboxPrint: I/O write bytes / time
407,150,592 / 314,704 03:01:07 INFO - TinderboxPrint: CPU idle
8,275.1 (86.8%) 03:01:07 INFO - TinderboxPrint: CPU user
1,206.6 (12.7%) 03:01:07 INFO - TinderboxPrint: Swap in / out
0 / 0 03:01:07 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 117739520; Read time: 0; Write time: 140516 03:01:07 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 73728; Write bytes: 289411072; Read time: 16; Write time: 174188 03:01:08 INFO - Running post-run listener: _upload_blobber_files 03:01:08 INFO - Blob upload gear active. 03:01:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:01:08 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 03:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:01:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:01:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:01:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:01:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:12 INFO - (blobuploader) - INFO - Done attempting. 03:01:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:01:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:01:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:13 INFO - (blobuploader) - INFO - Done attempting. 03:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:01:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:14 INFO - (blobuploader) - INFO - Done attempting. 03:01:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:01:14 INFO - Return code: 0 03:01:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:01:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:01:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/200abe7c11ec261986ca8e305a774dc236e2f56b026fd05456d317f728f33f637bc903a111fc9f333411e94d41ad186e93285b8d122fad18f1153b4d4bbc6fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c647f0cde12fc3daa49cf37fe8e85ffeb001de7e9766981dd3329d658a4f314a4136db21a5b1998bf29c97c17ef9e5f35a5d56c1506d274daaf9fe2fcf1ef40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/074ba139a4412e6108faed5aa33511f8892755569fb3bfe1b5deadedbd328ad0840e8205e615cd74f397ccb24452b7ea49e438795927830830ac24788dd797eb"} 03:01:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:01:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:01:14 INFO - Contents: 03:01:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/200abe7c11ec261986ca8e305a774dc236e2f56b026fd05456d317f728f33f637bc903a111fc9f333411e94d41ad186e93285b8d122fad18f1153b4d4bbc6fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c647f0cde12fc3daa49cf37fe8e85ffeb001de7e9766981dd3329d658a4f314a4136db21a5b1998bf29c97c17ef9e5f35a5d56c1506d274daaf9fe2fcf1ef40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/074ba139a4412e6108faed5aa33511f8892755569fb3bfe1b5deadedbd328ad0840e8205e615cd74f397ccb24452b7ea49e438795927830830ac24788dd797eb"} 03:01:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:01:14 INFO - Copying logs to upload dir... 03:01:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:01:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.219272 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-23 03:01:13.885655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 03:01:13.888657) ========= 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=41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/200abe7c11ec261986ca8e305a774dc236e2f56b026fd05456d317f728f33f637bc903a111fc9f333411e94d41ad186e93285b8d122fad18f1153b4d4bbc6fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c647f0cde12fc3daa49cf37fe8e85ffeb001de7e9766981dd3329d658a4f314a4136db21a5b1998bf29c97c17ef9e5f35a5d56c1506d274daaf9fe2fcf1ef40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/074ba139a4412e6108faed5aa33511f8892755569fb3bfe1b5deadedbd328ad0840e8205e615cd74f397ccb24452b7ea49e438795927830830ac24788dd797eb"} build_url:https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/axv-r0pETRyEfSvMy7-HUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/200abe7c11ec261986ca8e305a774dc236e2f56b026fd05456d317f728f33f637bc903a111fc9f333411e94d41ad186e93285b8d122fad18f1153b4d4bbc6fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c647f0cde12fc3daa49cf37fe8e85ffeb001de7e9766981dd3329d658a4f314a4136db21a5b1998bf29c97c17ef9e5f35a5d56c1506d274daaf9fe2fcf1ef40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/074ba139a4412e6108faed5aa33511f8892755569fb3bfe1b5deadedbd328ad0840e8205e615cd74f397ccb24452b7ea49e438795927830830ac24788dd797eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 03:01:13.913612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:01:13.913923) ========= 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=41a7e32711b8e08598a63237000001d6-1466674832.455029-1617254729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:01:13.998980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 03:01:13.999288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 03:01:13.999551) ========= ========= Total master_lag: 0.17 =========