builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1461558572.45 results: success (0) buildid: 20160424182636 builduid: b1a84459b7194c67b2cbcefbec04f387 revision: a07ea7fb572f503761e11fdae02f6d0340f157ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.450382) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.450863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.451138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.511411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.511724) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 21:29:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-04-24 21:29:32 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156851 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.700631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.700975) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.138847 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.851389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:32.851768) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a07ea7fb572f503761e11fdae02f6d0340f157ec --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 a07ea7fb572f503761e11fdae02f6d0340f157ec --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 21:29:32,906 truncating revision to first 12 chars 2016-04-24 21:29:32,906 Setting DEBUG logging. 2016-04-24 21:29:32,906 attempt 1/10 2016-04-24 21:29:32,906 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a07ea7fb572f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 21:29:33,189 unpacking tar archive at: fx-team-a07ea7fb572f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:33.483771) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:33.484074) ========= script_repo_revision: a07ea7fb572f503761e11fdae02f6d0340f157ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:33.484467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:33.484747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:33.733862) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-24 21:29:33.736200) ========= /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=14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:29:34 INFO - MultiFileLogger online at 20160424 21:29:34 in /builds/slave/test 21:29: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 21:29:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:29:34 INFO - {'append_to_log': False, 21:29:34 INFO - 'base_work_dir': '/builds/slave/test', 21:29:34 INFO - 'blob_upload_branch': 'Fx-Team', 21:29:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:29:34 INFO - 'branch': 'Fx-Team', 21:29:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:29:34 INFO - 'config_files': ('talos/linux_config.py',), 21:29:34 INFO - 'default_actions': ('clobber', 21:29:34 INFO - 'read-buildbot-config', 21:29:34 INFO - 'download-and-extract', 21:29:34 INFO - 'populate-webroot', 21:29:34 INFO - 'create-virtualenv', 21:29:34 INFO - 'install', 21:29:34 INFO - 'run-tests'), 21:29:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:29:34 INFO - 'download_minidump_stackwalk': True, 21:29:34 INFO - 'download_symbols': 'ondemand', 21:29:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:29:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:29:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:29:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:29:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:29:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:29:34 INFO - 'installer_path': 'installer.exe', 21:29:34 INFO - 'log_level': 'info', 21:29:34 INFO - 'log_name': 'talos', 21:29:34 INFO - 'log_to_console': True, 21:29:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:29:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:29:34 INFO - 'opt_config_files': (), 21:29:34 INFO - 'pip_index': False, 21:29:34 INFO - 'sps_profile': False, 21:29:34 INFO - 'sps_profile_interval': 0, 21:29:34 INFO - 'suite': 'dromaeojs', 21:29:34 INFO - 'system_bits': '32', 21:29:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:29:34 INFO - 'title': 'talos-linux64-ix-036', 21:29:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:29:34 INFO - 'use_talos_json': True, 21:29:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:29:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:29:34 INFO - 'work_dir': 'build'} 21:29:34 INFO - ##### 21:29:34 INFO - ##### Running clobber step. 21:29:34 INFO - ##### 21:29:34 INFO - Running pre-action listener: _resource_record_pre_action 21:29:34 INFO - Running main action method: clobber 21:29:34 INFO - rmtree: /builds/slave/test/build 21:29:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:29:36 INFO - Running post-action listener: _resource_record_post_action 21:29:36 INFO - ##### 21:29:36 INFO - ##### Running read-buildbot-config step. 21:29:36 INFO - ##### 21:29:36 INFO - Running pre-action listener: _resource_record_pre_action 21:29:36 INFO - Running main action method: read_buildbot_config 21:29:36 INFO - Using buildbot properties: 21:29:36 INFO - { 21:29:36 INFO - "project": "", 21:29:36 INFO - "product": "firefox", 21:29:36 INFO - "script_repo_revision": "production", 21:29:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:29:36 INFO - "repository": "", 21:29:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:29:36 INFO - "buildid": "20160424182636", 21:29:36 INFO - "pgo_build": "True", 21:29:36 INFO - "basedir": "/builds/slave/test", 21:29:36 INFO - "buildnumber": 60, 21:29:36 INFO - "slavename": "talos-linux64-ix-036", 21:29:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:29:36 INFO - "platform": "ubuntu64_hw", 21:29:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:29:36 INFO - "branch": "fx-team", 21:29:36 INFO - "repo_path": "integration/fx-team", 21:29:36 INFO - "revision": "a07ea7fb572f503761e11fdae02f6d0340f157ec", 21:29:36 INFO - "stage_platform": "linux64-pgo", 21:29:36 INFO - "builduid": "b1a84459b7194c67b2cbcefbec04f387", 21:29:36 INFO - "slavebuilddir": "test" 21:29:36 INFO - } 21:29:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:29:36 INFO - Running post-action listener: _resource_record_post_action 21:29:36 INFO - ##### 21:29:36 INFO - ##### Running download-and-extract step. 21:29:36 INFO - ##### 21:29:36 INFO - Running pre-action listener: _resource_record_pre_action 21:29:36 INFO - Running main action method: download_and_extract 21:29:36 INFO - mkdir: /builds/slave/test/build/tests 21:29:36 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')]} 21:29:36 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:29:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:29:41 INFO - Downloaded 1361 bytes. 21:29:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:41 INFO - Using the following test package requirements: 21:29:41 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:29:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:29:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:29:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'jsshell-linux-x86_64.zip'], 21:29:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:29:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:29:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:29:41 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:29:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:29:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:29:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:41 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:29:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:29:43 INFO - Downloaded 23857707 bytes. 21:29:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:29:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:29:44 INFO - Return code: 0 21:29:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:44 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:29:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:29:50 INFO - Downloaded 23857707 bytes. 21:29:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:29:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:29:52 INFO - Return code: 0 21:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:52 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:29:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:29:53 INFO - Downloaded 10840145 bytes. 21:29:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:29:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:29:53 INFO - Return code: 0 21:29: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')]} 21:29:53 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:29:55 INFO - Downloaded 58326869 bytes. 21:29:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:55 INFO - mkdir: /builds/slave/test/properties 21:29:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:29:55 INFO - Writing to file /builds/slave/test/properties/build_url 21:29:55 INFO - Contents: 21:29:55 INFO - build_url:https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:55 INFO - Running post-action listener: _resource_record_post_action 21:29:55 INFO - Running post-action listener: set_extra_try_arguments 21:29:55 INFO - ##### 21:29:55 INFO - ##### Running populate-webroot step. 21:29:55 INFO - ##### 21:29:55 INFO - Running pre-action listener: _resource_record_pre_action 21:29:55 INFO - Running main action method: populate_webroot 21:29:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:29:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:29:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:29:55 INFO - '--tppagecycles', 21:29:55 INFO - '7'], 21:29:55 INFO - 'tests': ['tsvgm']}}, 21:29:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:29:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:29:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:29:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:29:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:29:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:29:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:55 INFO - 'talos_options': ['--disable-e10s'], 21:29:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:55 INFO - 'talos_options': ['--disable-e10s'], 21:29:55 INFO - 'tests': ['damp', 'tps']}, 21:29:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:55 INFO - 'tests': ['damp', 'tps']}, 21:29:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:29:55 INFO - 'tests': ['dromaeo_dom']}, 21:29:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:29:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:29:55 INFO - 'tests': ['a11yr', 21:29:55 INFO - 'ts_paint', 21:29:55 INFO - 'tpaint', 21:29:55 INFO - 'sessionrestore', 21:29:55 INFO - 'sessionrestore_no_auto_restore', 21:29:55 INFO - 'tabpaint']}, 21:29:55 INFO - 'other-e10s': {'tests': ['a11yr', 21:29:55 INFO - 'ts_paint', 21:29:55 INFO - 'tpaint', 21:29:56 INFO - 'sessionrestore', 21:29:56 INFO - 'sessionrestore_no_auto_restore', 21:29:56 INFO - 'tabpaint']}, 21:29:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:29:56 INFO - 'ts_paint', 21:29:56 INFO - 'tpaint', 21:29:56 INFO - 'sessionrestore', 21:29:56 INFO - 'sessionrestore_no_auto_restore', 21:29:56 INFO - 'tabpaint']}, 21:29:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:29:56 INFO - 'ts_paint', 21:29:56 INFO - 'tpaint', 21:29:56 INFO - 'sessionrestore', 21:29:56 INFO - 'sessionrestore_no_auto_restore', 21:29:56 INFO - 'tabpaint']}, 21:29:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:29:56 INFO - 'tests': ['a11yr', 21:29:56 INFO - 'ts_paint', 21:29:56 INFO - 'tpaint', 21:29:56 INFO - 'sessionrestore', 21:29:56 INFO - 'sessionrestore_no_auto_restore', 21:29:56 INFO - 'tabpaint']}, 21:29:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:29:56 INFO - 'tests': ['a11yr', 21:29:56 INFO - 'ts_paint', 21:29:56 INFO - 'tpaint', 21:29:56 INFO - 'sessionrestore', 21:29:56 INFO - 'sessionrestore_no_auto_restore', 21:29:56 INFO - 'tabpaint']}, 21:29:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:29:56 INFO - 'tests': ['tsvgx', 21:29:56 INFO - 'tsvgr_opacity', 21:29:56 INFO - 'tart', 21:29:56 INFO - 'tscrollx', 21:29:56 INFO - 'cart']}, 21:29:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:29:56 INFO - 'tsvgr_opacity', 21:29:56 INFO - 'tart', 21:29:56 INFO - 'tscrollx', 21:29:56 INFO - 'cart']}, 21:29:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:56 INFO - 'talos_options': ['--disable-e10s'], 21:29:56 INFO - 'tests': ['tp5o']}, 21:29:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:56 INFO - 'tests': ['tp5o']}, 21:29:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:56 INFO - 'talos_options': ['--disable-e10s', 21:29:56 INFO - '--xperf_path', 21:29:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:56 INFO - 'tests': ['tp5n']}, 21:29:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:56 INFO - 'talos_options': ['--xperf_path', 21:29:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:56 INFO - 'tests': ['tp5n']}}, 21:29:56 INFO - 'talos.zip': {'path': '', 21:29:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:29:56 INFO - Running post-action listener: _resource_record_post_action 21:29:56 INFO - ##### 21:29:56 INFO - ##### Running create-virtualenv step. 21:29:56 INFO - ##### 21:29:56 INFO - Running pre-action listener: _resource_record_pre_action 21:29:56 INFO - Running main action method: create_virtualenv 21:29:56 INFO - Creating virtualenv /builds/slave/test/build/venv 21:29:56 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 21:29:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:29:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:29:56 INFO - Using real prefix '/usr' 21:29:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:29:57 INFO - Installing distribute.............................................................................................................................................................................................done. 21:29:59 INFO - Installing pip.................done. 21:29:59 INFO - Return code: 0 21:29:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:59 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 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:29:59 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 21:29:59 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 21:29:59 INFO - Using env: {'DISPLAY': ':0', 21:29:59 INFO - 'HOME': '/home/cltbld', 21:29:59 INFO - 'LANG': 'en_US.UTF-8', 21:29:59 INFO - 'LANGUAGE': 'en_US:en', 21:29:59 INFO - 'LOGNAME': 'cltbld', 21:29:59 INFO - 'MAIL': '/var/mail/cltbld', 21:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:59 INFO - 'MOZ_NO_REMOTE': '1', 21:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:59 INFO - 'NO_EM_RESTART': '1', 21:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:59 INFO - 'PWD': '/builds/slave/test', 21:29:59 INFO - 'SHELL': '/bin/bash', 21:29:59 INFO - 'SHLVL': '1', 21:29:59 INFO - 'TERM': 'linux', 21:29:59 INFO - 'TMOUT': '86400', 21:29:59 INFO - 'USER': 'cltbld', 21:29:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:59 INFO - '_': '/tools/buildbot/bin/python'} 21:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:59 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 21:29:59 INFO - Cleaning up... 21:29:59 INFO - Return code: 0 21:29:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:59 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:29:59 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>=0.7.1'] in /builds/slave/test/build 21:29:59 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>=0.7.1 21:29:59 INFO - Using env: {'DISPLAY': ':0', 21:29:59 INFO - 'HOME': '/home/cltbld', 21:29:59 INFO - 'LANG': 'en_US.UTF-8', 21:29:59 INFO - 'LANGUAGE': 'en_US:en', 21:29:59 INFO - 'LOGNAME': 'cltbld', 21:29:59 INFO - 'MAIL': '/var/mail/cltbld', 21:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:59 INFO - 'MOZ_NO_REMOTE': '1', 21:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:59 INFO - 'NO_EM_RESTART': '1', 21:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:59 INFO - 'PWD': '/builds/slave/test', 21:29:59 INFO - 'SHELL': '/bin/bash', 21:29:59 INFO - 'SHLVL': '1', 21:29:59 INFO - 'TERM': 'linux', 21:29:59 INFO - 'TMOUT': '86400', 21:29:59 INFO - 'USER': 'cltbld', 21:29:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:59 INFO - '_': '/tools/buildbot/bin/python'} 21:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:00 INFO - Downloading/unpacking psutil>=0.7.1 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:30:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:03 INFO - Installing collected packages: psutil 21:30:03 INFO - Running setup.py install for psutil 21:30:03 INFO - building 'psutil._psutil_linux' extension 21:30:03 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 21:30:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:30:04 INFO - building 'psutil._psutil_posix' extension 21:30:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:30:05 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 21:30:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:05 INFO - Successfully installed psutil 21:30:05 INFO - Cleaning up... 21:30:05 INFO - Return code: 0 21:30:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:05 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:30:05 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.0.0'] in /builds/slave/test/build 21:30:05 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.0.0 21:30:05 INFO - Using env: {'DISPLAY': ':0', 21:30:05 INFO - 'HOME': '/home/cltbld', 21:30:05 INFO - 'LANG': 'en_US.UTF-8', 21:30:05 INFO - 'LANGUAGE': 'en_US:en', 21:30:05 INFO - 'LOGNAME': 'cltbld', 21:30:05 INFO - 'MAIL': '/var/mail/cltbld', 21:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:05 INFO - 'MOZ_NO_REMOTE': '1', 21:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:05 INFO - 'NO_EM_RESTART': '1', 21:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:05 INFO - 'PWD': '/builds/slave/test', 21:30:05 INFO - 'SHELL': '/bin/bash', 21:30:05 INFO - 'SHLVL': '1', 21:30:05 INFO - 'TERM': 'linux', 21:30:05 INFO - 'TMOUT': '86400', 21:30:05 INFO - 'USER': 'cltbld', 21:30:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:05 INFO - '_': '/tools/buildbot/bin/python'} 21:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:30:05 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 21:30:05 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 21:30:05 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 21:30:05 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 21:30:05 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 21:30:05 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 21:30:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:30:07 INFO - Installing collected packages: mozsystemmonitor 21:30:07 INFO - Running setup.py install for mozsystemmonitor 21:30:07 INFO - Successfully installed mozsystemmonitor 21:30:07 INFO - Cleaning up... 21:30:07 INFO - Return code: 0 21:30:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:30:07 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')]} 21:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:07 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')]} 21:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:07 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 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:30:07 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 21:30:07 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 21:30:07 INFO - Using env: {'DISPLAY': ':0', 21:30:07 INFO - 'HOME': '/home/cltbld', 21:30:07 INFO - 'LANG': 'en_US.UTF-8', 21:30:07 INFO - 'LANGUAGE': 'en_US:en', 21:30:07 INFO - 'LOGNAME': 'cltbld', 21:30:07 INFO - 'MAIL': '/var/mail/cltbld', 21:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:07 INFO - 'MOZ_NO_REMOTE': '1', 21:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:07 INFO - 'NO_EM_RESTART': '1', 21:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:07 INFO - 'PWD': '/builds/slave/test', 21:30:07 INFO - 'SHELL': '/bin/bash', 21:30:07 INFO - 'SHLVL': '1', 21:30:07 INFO - 'TERM': 'linux', 21:30:07 INFO - 'TMOUT': '86400', 21:30:07 INFO - 'USER': 'cltbld', 21:30:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:07 INFO - '_': '/tools/buildbot/bin/python'} 21:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:07 INFO - Downloading/unpacking blobuploader==1.2.4 21:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:30:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:30:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:10 INFO - Downloading docopt-0.6.1.tar.gz 21:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:30:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:30:10 INFO - Running setup.py install for blobuploader 21:30:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:30:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:30:10 INFO - Running setup.py install for requests 21:30:10 INFO - Running setup.py install for docopt 21:30:10 INFO - Successfully installed blobuploader requests docopt 21:30:10 INFO - Cleaning up... 21:30:11 INFO - Return code: 0 21:30:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:11 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 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:30:11 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 21:30:11 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 21:30:11 INFO - Using env: {'DISPLAY': ':0', 21:30:11 INFO - 'HOME': '/home/cltbld', 21:30:11 INFO - 'LANG': 'en_US.UTF-8', 21:30:11 INFO - 'LANGUAGE': 'en_US:en', 21:30:11 INFO - 'LOGNAME': 'cltbld', 21:30:11 INFO - 'MAIL': '/var/mail/cltbld', 21:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:11 INFO - 'MOZ_NO_REMOTE': '1', 21:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:11 INFO - 'NO_EM_RESTART': '1', 21:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:11 INFO - 'PWD': '/builds/slave/test', 21:30:11 INFO - 'SHELL': '/bin/bash', 21:30:11 INFO - 'SHLVL': '1', 21:30:11 INFO - 'TERM': 'linux', 21:30:11 INFO - 'TMOUT': '86400', 21:30:11 INFO - 'USER': 'cltbld', 21:30:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:11 INFO - '_': '/tools/buildbot/bin/python'} 21:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:11 INFO - Running setup.py (path:/tmp/pip-Zb0lEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:11 INFO - Running setup.py (path:/tmp/pip-Jyy8qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:11 INFO - Running setup.py (path:/tmp/pip-Sw5CLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:11 INFO - Running setup.py (path:/tmp/pip-U21S18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:11 INFO - Running setup.py (path:/tmp/pip-Bwd4Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:11 INFO - Running setup.py (path:/tmp/pip-IQd7b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:11 INFO - Running setup.py (path:/tmp/pip-GiBCxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:11 INFO - Running setup.py (path:/tmp/pip-JmO34D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:11 INFO - Running setup.py (path:/tmp/pip-ulLxuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:11 INFO - Running setup.py (path:/tmp/pip-qVrd02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:11 INFO - Running setup.py (path:/tmp/pip-nGQOuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:12 INFO - Running setup.py (path:/tmp/pip-t5nUB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:12 INFO - Running setup.py (path:/tmp/pip-zM_XVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:12 INFO - Running setup.py (path:/tmp/pip-sTHaMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:12 INFO - Running setup.py (path:/tmp/pip-4MzFrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:12 INFO - Running setup.py (path:/tmp/pip-cGbKkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:12 INFO - Running setup.py (path:/tmp/pip-DlMlsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:30:12 INFO - Running setup.py install for manifestparser 21:30:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:30:12 INFO - Running setup.py install for mozcrash 21:30:12 INFO - Running setup.py install for mozdebug 21:30:12 INFO - Running setup.py install for mozdevice 21:30:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:30:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:30:12 INFO - Running setup.py install for mozfile 21:30:12 INFO - Running setup.py install for mozhttpd 21:30:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Running setup.py install for mozinfo 21:30:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Running setup.py install for mozInstall 21:30:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Running setup.py install for mozleak 21:30:13 INFO - Running setup.py install for mozlog 21:30:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Running setup.py install for moznetwork 21:30:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Running setup.py install for mozprocess 21:30:13 INFO - Running setup.py install for mozprofile 21:30:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Running setup.py install for mozrunner 21:30:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:30:13 INFO - Running setup.py install for mozscreenshot 21:30:14 INFO - Running setup.py install for moztest 21:30:14 INFO - Running setup.py install for mozversion 21:30:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:30:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:30:14 INFO - Cleaning up... 21:30:14 INFO - Return code: 0 21:30:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:14 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')]} 21:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:14 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')]} 21:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:14 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 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:30:14 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 21:30:14 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 21:30:14 INFO - Using env: {'DISPLAY': ':0', 21:30:14 INFO - 'HOME': '/home/cltbld', 21:30:14 INFO - 'LANG': 'en_US.UTF-8', 21:30:14 INFO - 'LANGUAGE': 'en_US:en', 21:30:14 INFO - 'LOGNAME': 'cltbld', 21:30:14 INFO - 'MAIL': '/var/mail/cltbld', 21:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:14 INFO - 'MOZ_NO_REMOTE': '1', 21:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:14 INFO - 'NO_EM_RESTART': '1', 21:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:14 INFO - 'PWD': '/builds/slave/test', 21:30:14 INFO - 'SHELL': '/bin/bash', 21:30:14 INFO - 'SHLVL': '1', 21:30:14 INFO - 'TERM': 'linux', 21:30:14 INFO - 'TMOUT': '86400', 21:30:14 INFO - 'USER': 'cltbld', 21:30:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:14 INFO - '_': '/tools/buildbot/bin/python'} 21:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:14 INFO - Running setup.py (path:/tmp/pip-owr_8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:14 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)) 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:14 INFO - Running setup.py (path:/tmp/pip-hlDywT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:14 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)) 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:14 INFO - Running setup.py (path:/tmp/pip-qq_iVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:14 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)) 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:14 INFO - Running setup.py (path:/tmp/pip-bsgNJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:14 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)) 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:14 INFO - Running setup.py (path:/tmp/pip-vFo2_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:14 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)) 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:14 INFO - Running setup.py (path:/tmp/pip-D4qJoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:14 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)) 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:14 INFO - Running setup.py (path:/tmp/pip-7wFkei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:14 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)) 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:14 INFO - Running setup.py (path:/tmp/pip-wGp71U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:15 INFO - Running setup.py (path:/tmp/pip-YfTjRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:15 INFO - Running setup.py (path:/tmp/pip-mjdAgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:15 INFO - Running setup.py (path:/tmp/pip-9Jn0Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:15 INFO - Running setup.py (path:/tmp/pip-quliK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:15 INFO - Running setup.py (path:/tmp/pip-RCbxMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:15 INFO - Running setup.py (path:/tmp/pip-1xJwoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:15 INFO - Running setup.py (path:/tmp/pip-CQovNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:15 INFO - Running setup.py (path:/tmp/pip-swB76d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:15 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)) 21:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:15 INFO - Running setup.py (path:/tmp/pip-G4GBnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:15 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)) 21:30:15 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)) 21:30:15 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)) 21:30:15 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)) 21:30:15 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)) 21:30:15 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)) 21:30:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:15 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 21:30:15 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 21:30:15 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 21:30:15 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 21:30:15 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 21:30:15 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 21:30:17 INFO - Downloading blessings-1.6.tar.gz 21:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:30:17 INFO - Installing collected packages: blessings 21:30:17 INFO - Running setup.py install for blessings 21:30:17 INFO - Successfully installed blessings 21:30:17 INFO - Cleaning up... 21:30:17 INFO - Return code: 0 21:30:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:17 INFO - Reading from file tmpfile_stdout 21:30:18 INFO - Current package versions: 21:30:18 INFO - argparse == 1.2.1 21:30:18 INFO - blessings == 1.6 21:30:18 INFO - blobuploader == 1.2.4 21:30:18 INFO - docopt == 0.6.1 21:30:18 INFO - manifestparser == 1.1 21:30:18 INFO - mozInstall == 1.12 21:30:18 INFO - mozcrash == 0.17 21:30:18 INFO - mozdebug == 0.1 21:30:18 INFO - mozdevice == 0.48 21:30:18 INFO - mozfile == 1.2 21:30:18 INFO - mozhttpd == 0.7 21:30:18 INFO - mozinfo == 0.9 21:30:18 INFO - mozleak == 0.1 21:30:18 INFO - mozlog == 3.1 21:30:18 INFO - moznetwork == 0.27 21:30:18 INFO - mozprocess == 0.22 21:30:18 INFO - mozprofile == 0.28 21:30:18 INFO - mozrunner == 6.11 21:30:18 INFO - mozscreenshot == 0.1 21:30:18 INFO - mozsystemmonitor == 0.0 21:30:18 INFO - moztest == 0.7 21:30:18 INFO - mozversion == 1.4 21:30:18 INFO - psutil == 3.1.1 21:30:18 INFO - requests == 1.2.3 21:30:18 INFO - wsgiref == 0.1.2 21:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:18 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 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:30:18 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 21:30:18 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 21:30:18 INFO - Using env: {'DISPLAY': ':0', 21:30:18 INFO - 'HOME': '/home/cltbld', 21:30:18 INFO - 'LANG': 'en_US.UTF-8', 21:30:18 INFO - 'LANGUAGE': 'en_US:en', 21:30:18 INFO - 'LOGNAME': 'cltbld', 21:30:18 INFO - 'MAIL': '/var/mail/cltbld', 21:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:18 INFO - 'MOZ_NO_REMOTE': '1', 21:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:18 INFO - 'NO_EM_RESTART': '1', 21:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:18 INFO - 'PWD': '/builds/slave/test', 21:30:18 INFO - 'SHELL': '/bin/bash', 21:30:18 INFO - 'SHLVL': '1', 21:30:18 INFO - 'TERM': 'linux', 21:30:18 INFO - 'TMOUT': '86400', 21:30:18 INFO - 'USER': 'cltbld', 21:30:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:18 INFO - '_': '/tools/buildbot/bin/python'} 21:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 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)) 21:30:18 INFO - Cleaning up... 21:30:18 INFO - Return code: 0 21:30:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:18 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 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:30:18 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 21:30:18 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 21:30:18 INFO - Using env: {'DISPLAY': ':0', 21:30:18 INFO - 'HOME': '/home/cltbld', 21:30:18 INFO - 'LANG': 'en_US.UTF-8', 21:30:18 INFO - 'LANGUAGE': 'en_US:en', 21:30:18 INFO - 'LOGNAME': 'cltbld', 21:30:18 INFO - 'MAIL': '/var/mail/cltbld', 21:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:18 INFO - 'MOZ_NO_REMOTE': '1', 21:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:18 INFO - 'NO_EM_RESTART': '1', 21:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:18 INFO - 'PWD': '/builds/slave/test', 21:30:18 INFO - 'SHELL': '/bin/bash', 21:30:18 INFO - 'SHLVL': '1', 21:30:18 INFO - 'TERM': 'linux', 21:30:18 INFO - 'TMOUT': '86400', 21:30:18 INFO - 'USER': 'cltbld', 21:30:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:18 INFO - '_': '/tools/buildbot/bin/python'} 21:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:18 INFO - Downloading/unpacking jsonschema 21:30:18 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 21:30:18 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 21:30:18 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 21:30:18 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 21:30:18 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 21:30:18 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 21:30:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:30:20 INFO - Downloading/unpacking functools32 (from jsonschema) 21:30:20 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 21:30:20 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 21:30:20 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 21:30:20 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 21:30:20 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 21:30:20 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 21:30:20 INFO - Downloading functools32-3.2.3-2.tar.gz 21:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:30:20 INFO - warning: no files found matching '*.txt' 21:30:20 INFO - no previously-included directories found matching 'build' 21:30:20 INFO - no previously-included directories found matching 'dist' 21:30:20 INFO - no previously-included directories found matching '.git*' 21:30:20 INFO - Installing collected packages: jsonschema, functools32 21:30:20 INFO - Running setup.py install for functools32 21:30:20 INFO - warning: no files found matching '*.txt' 21:30:20 INFO - no previously-included directories found matching 'build' 21:30:20 INFO - no previously-included directories found matching 'dist' 21:30:20 INFO - no previously-included directories found matching '.git*' 21:30:20 INFO - Successfully installed jsonschema functools32 21:30:20 INFO - Cleaning up... 21:30:20 INFO - Return code: 0 21:30:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe3722bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', '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 21:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:30:20 INFO - Using env: {'DISPLAY': ':0', 21:30:20 INFO - 'HOME': '/home/cltbld', 21:30:20 INFO - 'LANG': 'en_US.UTF-8', 21:30:20 INFO - 'LANGUAGE': 'en_US:en', 21:30:20 INFO - 'LOGNAME': 'cltbld', 21:30:20 INFO - 'MAIL': '/var/mail/cltbld', 21:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:20 INFO - 'MOZ_NO_REMOTE': '1', 21:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:20 INFO - 'NO_EM_RESTART': '1', 21:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:20 INFO - 'PWD': '/builds/slave/test', 21:30:20 INFO - 'SHELL': '/bin/bash', 21:30:20 INFO - 'SHLVL': '1', 21:30:20 INFO - 'TERM': 'linux', 21:30:20 INFO - 'TMOUT': '86400', 21:30:20 INFO - 'USER': 'cltbld', 21:30:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:20 INFO - '_': '/tools/buildbot/bin/python'} 21:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:21 INFO - Downloading/unpacking flake8 21:30:21 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 21:30:21 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 21:30:21 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 21:30:21 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 21:30:21 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 21:30:21 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 21:30:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:30:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:30:22 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 21:30:22 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 21:30:22 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 21:30:22 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 21:30:22 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 21:30:22 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 21:30:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:30:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 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 21:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:30:23 INFO - no previously-included directories found matching 'docs/_build' 21:30:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:30:23 INFO - Running setup.py install for pep8 21:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:30:23 INFO - no previously-included directories found matching 'docs/_build' 21:30:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:30:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:30:23 INFO - Cleaning up... 21:30:23 INFO - Return code: 0 21:30:23 INFO - Running post-action listener: _resource_record_post_action 21:30:23 INFO - Running post-action listener: _start_resource_monitoring 21:30:23 INFO - Starting resource monitoring. 21:30:23 INFO - ##### 21:30:23 INFO - ##### Running install step. 21:30:23 INFO - ##### 21:30:23 INFO - Running pre-action listener: _resource_record_pre_action 21:30:23 INFO - Running main action method: install 21:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:24 INFO - Reading from file tmpfile_stdout 21:30:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:30:24 INFO - Reading from file tmpfile_stdout 21:30:24 INFO - Output received: 21:30:24 INFO - Usage: mozinstall [options] installer 21:30:24 INFO - Options: 21:30:24 INFO - -h, --help show this help message and exit 21:30:24 INFO - -d DEST, --destination=DEST 21:30:24 INFO - Directory to install application into. [default: 21:30:24 INFO - "/builds/slave/test"] 21:30:24 INFO - --app=APP Application being installed. [default: firefox] 21:30:24 INFO - mkdir: /builds/slave/test/build/application 21:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:30:40 INFO - Reading from file tmpfile_stdout 21:30:40 INFO - Output received: 21:30:40 INFO - /builds/slave/test/build/application/firefox/firefox 21:30:40 INFO - Running post-action listener: _resource_record_post_action 21:30:40 INFO - ##### 21:30:40 INFO - ##### Running run-tests step. 21:30:40 INFO - ##### 21:30:40 INFO - Running pre-action listener: _resource_record_pre_action 21:30:40 INFO - Running main action method: run_tests 21:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:30:40 INFO - Python 2.7.3 21:30:40 INFO - Return code: 0 21:30:40 INFO - grabbing minidump binary from tooltool 21:30: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')]} 21:30:40 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d810>, '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 0x1c9e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9eba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:30:40 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 21:30:40 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 21:30:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:30:40 INFO - Return code: 0 21:30:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:30:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:30:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:30:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:30:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:30:41 INFO - Return code: 0 21:30:41 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/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:30:41 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/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:30:41 INFO - Using env: {'DISPLAY': ':0', 21:30:41 INFO - 'HOME': '/home/cltbld', 21:30:41 INFO - 'LANG': 'en_US.UTF-8', 21:30:41 INFO - 'LANGUAGE': 'en_US:en', 21:30:41 INFO - 'LOGNAME': 'cltbld', 21:30:41 INFO - 'MAIL': '/var/mail/cltbld', 21:30:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:30:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:41 INFO - 'MOZ_NO_REMOTE': '1', 21:30:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:41 INFO - 'NO_EM_RESTART': '1', 21:30:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:41 INFO - 'PWD': '/builds/slave/test', 21:30:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:30:41 INFO - 'SHELL': '/bin/bash', 21:30:41 INFO - 'SHLVL': '1', 21:30:41 INFO - 'TERM': 'linux', 21:30:41 INFO - 'TMOUT': '86400', 21:30:41 INFO - 'USER': 'cltbld', 21:30:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045', 21:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:41 INFO - '_': '/tools/buildbot/bin/python'} 21:30:41 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/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:30:42 INFO - mozversion application_buildid: 20160424182636 21:30:42 INFO - mozversion application_changeset: a07ea7fb572f503761e11fdae02f6d0340f157ec 21:30:42 INFO - mozversion application_display_name: Nightly 21:30:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:30:42 INFO - mozversion application_name: Firefox 21:30:42 INFO - mozversion application_remotingname: firefox 21:30:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:30:42 INFO - mozversion application_vendor: Mozilla 21:30:42 INFO - mozversion application_version: 48.0a1 21:30:42 INFO - mozversion platform_buildid: 20160424182636 21:30:42 INFO - mozversion platform_changeset: a07ea7fb572f503761e11fdae02f6d0340f157ec 21:30:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:30:42 INFO - mozversion platform_version: 48.0a1 21:30:42 INFO - using testdate: 1461558642 21:30:42 INFO - actual date: 1461558642 21:30:42 INFO - starting webserver on 'localhost:37665' 21:30:42 INFO - SUITE-START | Running 2 tests 21:30:42 INFO - TEST-START | dromaeo_css 21:30:42 INFO - operating with platform_type : linux_ 21:30:42 INFO - Initialising browser for dromaeo_css test... 21:30:42 INFO - TEST-INFO | started process 3288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5NsAX/profile http://localhost:37665/getInfo.html) 21:30:51 INFO - PROCESS | 3288 | __metrics Screen width/height:1600/1200 21:30:51 INFO - PROCESS | 3288 | colorDepth:24 21:30:51 INFO - PROCESS | 3288 | Browser inner width/height: 1024/697 21:30:51 INFO - PROCESS | 3288 | __metrics 21:30:52 ERROR - PROCESS | 3288 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:30:53 INFO - TEST-INFO | 3288: exit 0 21:30:53 INFO - Browser initialized. 21:30:53 INFO - Running cycle 1/1 for dromaeo_css test... 21:30:53 INFO - TEST-INFO | started process 3372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5NsAX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:05 INFO - PROCESS | 3372 | RSS: Main: 153554944 21:31:05 INFO - PROCESS | 3372 | 21:31:56 INFO - PROCESS | 3372 | 1461558716439 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] 21:34:04 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37665/tests/dromaeo/cssquery-ext.html) 21:34:05 INFO - PROCESS | 3372 | RSS: Main: 253358080 21:34:05 INFO - PROCESS | 3372 | 21:37:07 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-ext.html (next: http://localhost:37665/tests/dromaeo/cssquery-jquery.html) 21:37:08 INFO - PROCESS | 3372 | RSS: Main: 234688512 21:37:08 INFO - PROCESS | 3372 | 21:40:09 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37665/tests/dromaeo/cssquery-mootools.html) 21:40:10 INFO - PROCESS | 3372 | RSS: Main: 236478464 21:40:10 INFO - PROCESS | 3372 | 21:43:12 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37665/tests/dromaeo/cssquery-prototype.html) 21:43:13 INFO - PROCESS | 3372 | RSS: Main: 227090432 21:43:13 INFO - PROCESS | 3372 | 21:46:15 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37665/tests/dromaeo/cssquery-yui.html) 21:46:16 INFO - PROCESS | 3372 | RSS: Main: 224743424 21:46:16 INFO - PROCESS | 3372 | 21:49:18 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-yui.html (next: http://localhost:37665/tests/dromaeo/cssquery-dojo.html) 21:49:19 INFO - PROCESS | 3372 | RSS: Main: 255516672 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | __start_tp_report 21:49:19 INFO - PROCESS | 3372 | _x_x_mozilla_page_load 21:49:19 INFO - PROCESS | 3372 | _x_x_mozilla_page_load_details 21:49:19 INFO - PROCESS | 3372 | |i|pagename|runs| 21:49:19 INFO - PROCESS | 3372 | |0;dojo.html;3088.289693370524;3139.591853059102;3177.1580531159248;3186.920326991825;3206.759493038022;5238.214267859823;5249.527542521172;5266.76299566519;5277.182036784295;5293.602979776518;5302.708351040691;5330.813421530247;5334.67991920485;5336.706481143536;5350.224217488462;4740.644451666121;4792.04159168166;4901.338319326881;4937.358143441347;4968.428630707479;4867.13314594423;4882.658213925027;4908.533689299528;4922.237053256733;4923.409190897098;4687.976560117195;4690.319903613991;4699.0836786826585;4789.664723469358;4806.95193048072;4710.62315014798;4723.7874295656775;4730.053989202139;4731.4795372509;4754.643401744848;4699.2481203007355;4702.858914232578;4726.291056341542;4736.076465089309;4769.260764581495;5147.871303217412;5187.792488300463;5219.373675159005;5248.8425347239645;5258.316418865561;5658.7170641467765;5674.2339784129435;5682.431756824326;5686.658800471985;5692.203091567184;5590.5527557795685;5658.405867383948;5726.9713651431475;5731.942680573225;5733;5318.946810531884;5363.410024897258;5368.087425137697;5375.3280839895015;5377.46225377463;5834.5624078194305;5835.503982161479;5838.153467747238;5846.269216347957;5846.766129354864;5469.371022332403;5532.944670553324;5600.85997850057;5616.971915140398;5628.774849006076;5605.411431799684;5611.663300202001;5621.241132447068;5631.7184140793615;5692.345380281238;5612.719364031864;5616.438356164351;5620.016497112989;5626.324841019104;5630.352509461464;5540.196671482612;5628.493435590816;5649.265595472562;5728.112142617901;5762.94237057624;4303.182395344875;4304.096139810612;4306.935395969063;4307.892302692395;4336.891577710519;3837.2517359114704;3863.2273545291055;3868.787216703052;3882.2235552889533;3888.844446222176;5270.631055826132;5299.046171689133;5340.06548853949;5361.651492652965;5393.703346315911;5630.60585758993;5631.774729010794;5648.124540696199;5649.519790817744;5658.377578466366;5264.052470555337;5293.311869457023;5324.733763311819;5336.17289320156;5384.353877534642;4855.44162421319;4874.46380898101;4880;4929.950700493021;4930.359053323045;5849.707514624251;5866.384029676908;5869.589128761031;5871.64770113786;5873.676947767914;5574.91637625444;5671.262735844314;5706.28671416073;5707.343655479673;5743.0811070228565;5787.94212057874;5797.91303130445;5808.448197421239;5818.679972601378;5831.446012628793;5491.615586908878;5493.945060549343;5495.890082198253;5500.367457742411;5546.639468434539;5572.108462645957;5604.607677462702;5627.324721033502;5637.520810731134;5726.2269593606;5537.307836520435;5540.63985840919;5561;5575.470330318613;5589.329280486368;5487.835364939058;5493.23094766725;5499.202615620633;5504.862378440571;5516.255305533701;5367.651102678314;5424.430434804446;5427.104527753035;5507.421720719267;5511.751971161388;5552.056150454352;5571.470710282517;5588.692621905834;5588.972055139699;5609.915851262316;5461.863453413696;5462.726863656721;5469.179623056414;5470.960517501662;5479.123340265538 21:49:19 INFO - PROCESS | 3372 | |1;ext.html;593.4540222994844;622.1445512420422;639.5107742576927;644.4683136412461;660.3759447322279;31767;32509.02472925813;36976.63023369765;38202.4269635955;38308.425373619415;40901.18197636046;41694;41703.374449383286;41747.16505669885;41814;8425.199606037417;8566.100559441262;8625.094365091669;8630.784230394227;8636.956815215915;8481.787955301135;8608;8611.741647750578;8612.39713220075;8616.65533378664;8830.337724670675;8906.020337762873;8909.153630405133;8912.331575131859;8913.153250441197;8795;8868.290536757044;8872;8877.866831997526;8884.955575222082;8664.740057798275;8736.737897863075;8765.685147227903;8776.254018408443;8778.385513014091;39773;40730.796346018375;40765.184696306205;40767.59232407668;40813.38779918304;3351.6145643251093;3442.4836274558766;4014.2774300625874;4114.341705327133;4155.4182414462;30429.543556846664;30956;31256.37487250265;31346.529802052988;32384.5142322863;3799.4870692456716;3820.59883712209;3889.630485103939;3981.6416522513114;4139.379093136024;455249;463767.36232637917;464225;465464;465590;57870.421295787346;58072.419275807544;58346.12480812791;58391.12413313804;58402.7079864598;62731;63877.68061159665;64293.678531607045;64478.35521644817;64500.354996450376;14932.850671493146;15214.543563693107;15220.771688424682;15222.46721364747;15234.771478427832;10945.069669078217;10946.507407166697;10972.451377431096;10975.28660637056;10991.505382257817;18594.907025464785;18602.906985464986;18764.624707505773;19244.23023079061;19374.51258773434;7093.503454758117;7213.799791063671;7284.579506996085;7332.8900066499045;7334.96332518334;1024.8872624011353;1047.696168111239;1112.710695219249;1131.671815173607;1189.4409627475072;30769.538456923165;32128;32271.838640807116;32275.677243227736;32528.674713253036;1101.1411099342527;1136.2557524821254;1144.9198556100994;1149.0635132367095;1151.7408583068743;16869.32522699103;17220.1389930503;17347.392841250497;17422.390216342366;17455.770682423794;440234;446415;448159;448498;450524;56777.14834277407;58314;58315.416845831845;58457.70771146117;58476.41523584795;1349.413005342679;1362.434589645286;1387.6808334083016;1406.381192275416;1410.6261840612246;27618.309542261602;30739.385212295183;32172.83913580511;33422.49866252057;36427.27145457129;56871.71564142153;57610.423895760505;57960;57978.420215797305;58015.12977305259;411891;412227;413182;417289;417517;35693.64306357007;37011.61300577156;43148.352774707775;43775;43866.34200487059;41728.16543669171;41891.581084188765;42492;42581;43001;37379.25241495209;39740;39992.80003599964;40348.79825600853;40660.59339406568;38351;39524;39533;39559;39978.2004359917;39503.60496394999;39776.60223397729;40214.396784047676;40218.1956360877;40235.39646905357;33706.66293337035;34088.318233635684;34990.47514287237;35096.824515877255;35335.11662208466;26981.730182698706;27160.72839271582;27447.45105097847;27622.5856612155;27658.44683106367 21:49:19 INFO - PROCESS | 3372 | |2;jquery.html;392.9646331830136;393.71849127873566;398.63325740318913;400.9258287216865;408.6016134269088;16946.91526542367;17810;18048;18236.45290641281;18272.269109235633;17472.563185920357;17665.55836104098;18227.635447291046;18609.255629774794;18664.253429862823;5640.520555752766;5699.829005129853;5742.052561327376;5793.13103034544;5816.243888294516;5554.50009499145;5672.40439753824;5729.885402291951;5770.105633626774;5772.134179873011;5552.694601796899;5675.233843431146;5686.289213848269;5692.829215123532;5919.319278282988;5864.5894787364905;5875;5878.794242201545;5882.117682347639;5913.940860591403;5548.056830338852;5706.343770466408;5720.856978575569;5741.45456181662;5754.424557544254;13678.726425471436;13888.23614701191;13888.652783680387;24130.155444559357;25413.364665883317;2460.8400453970435;2565.3586603349163;2679.6918354389104;2779.1523585306472;2989.5814585957764;14313.284335783273;15593.844061559352;15725.685486290211;15845.651469451923;16128.112953787537;2078.147959336665;2180.0843645668856;2182.792634699717;2224.265992222579;2246.449619843149;87166;89174;90186;90633.54683226542;92187;17060;17385.913070434566;17401.825981740272;17742.467725968243;17743.55641108957;31705.36589268248;31821;31953.52069718956;31971.840140799148;32129.51805722916;9183.311251656152;9297.814043719087;9392.107749763762;9489.810203795885;9725.367851089657;7678.347340476123;7739.7678069658;7851.214878512217;7867.291943725092;7874.125944030502;8655.639845790325;8733.694320698745;8817.811539518805;8959.865602015974;9038.276937844958;3104.221721559237;3255.5604993325596;3470;3472.166679996833;3491.9873236761055;869.4261787220404;1006.225206590921;1007.3955626623967;1061.3295438171058;1062.1661995333625;18383.632327353378;19170.904145479184;19216;19219.231230750895;19278.22887084529;1025;1039.3504059962524;1042.4527123260198;1049.2602715085998;1121.6410748560381;10421.791564168674;10701.518431670438;10732.570697172026;10957.616483423042;10960.232783705063;447565;455586;462106;466740;468293;84035;93242;93354.0664593359;93368.53315733378;93732.53133734288;1033;1036.7459972306833;1100.114407901647;1103.564092183599;1121.3047910295668;16465.753013705045;16728.91635541863;16880.155992200587;17071.40250091241;17301.56746081358;37045;37123.814380929005;38774.61225387823;38914.2217155661;39222;48735.26897096475;49128.00967274959;56954;57420.13869791873;58058;8183.902992270796;8301.211384918422;8411.789705257417;8590.01214860274;8664.220220180214;9392.248620110511;11413.828792567952;11786.823197652213;12153.02775777918;12477.75044499123;7329.9267007329245;11201.271917325348;11346.546138154381;11481;11643.53425862956;11098.66703998849;11101.50043248072;11133.777324453627;11199.048080913213;11269.830952535882;6366.9681651591445;8859.557022148738;11320.547178112784;11393.829092563785;11475.48360323804;8194.38542109356;8202.138775428493;8292.253697167283;8330.083690794128;8391.021187478602;10816.945915270373;11040.668779936615;11203.88796112061;11326.093912487146;11350.489227984595 21:49:19 INFO - PROCESS | 3372 | |3;mootools.html;1386.3830595385057;1489.3000289863767;1519.498565473394;1692.983070169298;1815.8274963878428;8065.112837587868;8412.66349346027;8413.663453461853;8418.663253469862;8427.578621068946;8191.180881911806;8353.248207661309;8358.874616880736;8360.665573377057;8378.078411374743;2075.647139986206;2282.851614645043;2316.9073237070497;2348.248560460653;2361.067378385537;2207.106122020576;2233.1848875160613;2235.8211343092594;2239.5296987632537;2241.8766967816846;2252.2905284835306;2310.6187479065934;2317.5480781247666;2317.6755254264417;2321.106374045996;2042.908069136885;2215.4129155773735;2272.0798076778933;2277.6811246425514;2283.3492454650345;2204.834637402201;2211.800937915595;2214.55708858229;2218.589560931233;2291.346966114666;8112.188781121899;8265.752027439186;8281.54451505167;8297.25324720772;8299.29455996241;4901.632377571696;5032.245163225509;5075.21334193197;5089.567386772129;5140.794368225266;3320.767546271762;3385.1029477188563;3425.6745609167087;3446.552447971858;3453.240287136826;1173.976520469586;1200.675817529271;1210.5339444314002;1228.8709685483075;1233.5990802988974;10892.509837057352;10913.23607347486;10931;10931.398773067478;10936.453177341102;4332.610065094157;4334.869953901325;4515.661325400608;4569.588737013618;4587.518310577341;9482.810343793224;9489.430634161972;9495.477748723748;9508.381955172892;9508.667196648084;4678.485366609671;5037.82367617139;5041.991601679679;5047;5064.82273120439;4700.788464519105;4783.521647835259;4789.114013907439;4795.088933102699;4816.084943860656;3863.343231650626;3894.5131858517684;3942.1327307992196;3996.6003399659803;3997.4603428537357;1279.1365828066018;1289.4004288006122;1310.0894878059657;1313.9934300328628;1324.536412255722;914.1955079529971;1009.3035805294323;1009.5305682857506;1021.0912288063629;1027.9691609251734;6092.482139018144;6095.603785753912;6142.938570614326;6222.968885155546;6242.843928901723;462.1219682603014;462.28115280738103;472.091224393042;478.85155601763563;482.39700374531833;4254.659627229814;4279.850205242801;4308.46144231971;4309.332053531708;4321.092570560218;9938.354006989523;10209.234307426972;10463.84304235437;10480;10483.37099774016;10212.897871021343;10310.690679279634;10315.432651204106;10357.274990750575;10386.767939236397;7605.543667379975;7816.374690024784;7962.363010959225;7967.521948683097;7978.521288722695;5863.472287494146;5994.820155395345;6004.279486461653;6053.969730151497;6089.725962331617;9296.535173241176;9422.670206542738;9464.384814987005;9475.147236748726;9560.665376711782;9444.244460443286;9755.073268039525;9778.364406313567;9885.505724713592;9920.652777152765;6994.895076573957;7299.124105107421;7470.439717021354;7603.619819009138;7748.8450230996195;8311;8322.791930201793;8381.832363352822;8403.327733781161;8422;7464.701411943462;7561.168271490022;7651.234876512304;7685.577293248702;7710.537367757728;7342.70629174827;7374.778756637309;7444.962775186089;7460.66427010775;7549.282818132268;6816.591004539743;6828.7268509259075;6881.862362752817;6894.276101009322;6897.034415181979;5075.720835354091;5082.136036873666;5289.841304760864;5314.920276195783;5336.279602253646;5319.4414586467865;5323.281357016908;5361.24942508057;5385.73071346439;5424.83725488236 21:49:19 INFO - PROCESS | 3372 | |4;prototype.html;316.87325069971996;332.78202777180945;335.9049498634451;336.725568661541;337.93072420153857;5392.757325920328;5452.536534394576;5541.473560011797;5574.581906357029;5616.971915140419;5461.290032295806;5513.807016754415;5524.364698059724;5528.806491772789;5530.474604912537;4302.956970430295;4304.24675681756;4305.117450922569;4315.158544083905;4323.1353729254115;4226.556211597784;4288.228118938589;4288.463942007249;4293.849715259951;4324.07032488015;4238.894027649302;4242.236397448458;4272;4277.764722940237;4283;4277.379779931908;4284.828606855722;4286.935695964563;4292.2917718576555;4300.849470268541;3663.8900832975055;3796.373598356268;3809.447630093621;3816.484774555427;3816.885493435201;5303;5317.335333083364;5324.1747529133045;5341.359036915556;5342.171963345688;4919.483454237289;4958.900821983576;4977.576905962997;4980.327655766461;4987;5633.408492108351;5769.423057694239;5773.971130144364;5810.327249465251;5874.089516125007;4211.115665710205;4226.556211597799;4239.745615263094;4240.724352917051;4245.10852720929;5730.570207234432;5814.418558144152;6021.909671354933;6046.667433291167;6074.696265186767;4282.464691913511;4285.721428107163;4293.484781826139;4299.462567179103;4316.5467625899455;4318.676099292566;4347.478302603708;4357.891052723644;4360.542143074995;4374.540673229329;4696.2955556666775;4713.34013238147;4883.853484395474;4924.138275801721;5000.174971129795;5823.56323275756;5860.560457965669;5881.32364778056;5887.587868849139;5891.351951285355;1506.1189204315378;1518.5042732908078;1527.5188315680525;1528.8318284988643;1535.4318902006105;1012.1700205831148;1038.9688309350731;1059.2532264753331;1063.2504084620325;1069.5668254356997;5541.612087153861;5544.445555444423;5590.972045139748;5593.8601534961135;5595.7481913313995;5960.254968128984;5976.880462390728;5980.970095149496;5981.611195272293;5985.9401405986255;5369.6509726867625;5599.8600034998635;5613.775448982076;5620.887582248332;5641.323041234996;3185.8088514689193;3204.4552426087157;3223.1942014496376;3223.3875563642832;3228.4511633022444;5962.135490353961;6235.719392627343;6246.407740787613;6252.343503932022;6289.150964619717;6145.5698101133385;6153.784617538365;6160.445559899541;6190.288116866528;6190.511878887771;6233.906491402633;6251.812445626639;6265.373462653698;6271.905921411182;6272.905906411316;5825.94174058254;6094.75620975156;6102.633841969496;6109.633421994695;6113.480354169946;5979.790707325223;6014.398560143951;6024.9397506026135;6040.818775436744;6042.3655516170165;5978.252718410199;6083.726232319467;6244.313125556276;6252.843678908063;6279.0267508534425;4207.389928460418;4224.598663126998;4226.13364260332;4230.894227644333;4241.893952651209;5909.468147866713;6052.334243233329;6057.121717351048;6060.2424696912885;6080.604760690541;5899.203607512931;5911.733971971185;5915.674637894785;5928.584999050025;5944.405559444021;5908.556858235564;5909.52723782105;5919.496842768241;5922.407759224043;5926.288845338587;5666.46168613981;5785.450382213683;5809.36097029318;5834.38738932406;5836.649801011953;5877.676727780014;5923.170756094064;5935.436133567304;5938.673372964528;5940.346561878277;5708.257926469532;5757.157709533077;5802.187693722798;5817.156512305776;5829.5336373090895 21:49:19 INFO - PROCESS | 3372 | |5;yui.html;822.8230930349976;834.3867257565691;846.7375113714747;863.6243234193126;875.3959767760241;14159.858401415995;14737;14765.77851332231;14775.926120369397;14786.926065369686;15102.697946041073;15147.848521514781;15157.242137893089;15171.393144274243;15254.313555889983;686.5708931917552;791.7387262203459;810.6514198894473;819.8114433680228;826.0912995704707;821.7288294862681;824.72371755462;824.9216324449168;825.162460102996;825.9091499935003;861.130258438978;864.7362554420899;864.9308055355588;865.4201684871151;866.5927014303268;710.0627172132787;834.7579202031434;856.8072183758667;856.87146927961;857.0743596915316;625.809128215894;625.9248890133167;627.0594108836744;627.0813258576162;627.5418944170781;14476.710465790731;14573.6356591085;14646.487372941896;14663.70672586553;14670.26648667573;13543.119697219649;13757;13840.653983650389;13905.235212063333;14010.159390436607;11472;11594.188406811527;11770.941145294219;11991.460384282727;12107;3866.3427217372832;3904.121572646132;3906.980465097685;3960.6237407446533;4019.2363450944226;54950.45049549533;55163.724181379235;55277.9999999996;55510.44489555093;55871;10422.739431514121;10507.159427245802;10710.196735244888;10718.35689858611;10803.189760767973;19359.12883920227;19518.804811951984;19614.607707845764;19615.803841961682;19631.803681963283;7887.842243155104;7990.240927111915;8009.879851802111;8161.143079976517;8330.125336839666;4606.677532572688;4643.605293550018;4662.487126416091;4679.461861885927;4688.203005489075;3409.7613167078066;3448.7241020718284;3452.4993875887853;3459.0487615905827;3459.3773120837986;595.6455908734296;608.8477880529867;615.2801222569605;617.9165812615329;656.2092678322609;661.0876989754108;708.6598432752307;724.9166345870187;752.4243953375671;758.772368289511;9264.166225039779;9272.795705314913;9362.485063321583;9374.85937710935;9514.476703781358;534.7540131539457;604.4590091867753;637.209859773877;703.3494018033299;716.1549371741291;4442.933355999663;4449.354843547668;4494.270843640558;4573.268277075718;4575.519570445055;59906.400935990954;60034.399656003756;61967.690161548904;62073.689631551555;62544;52383.73808131011;54097.1885421719;54968.45031549633;55263.723681381336;56052.71973640106;44612.776936115115;44690.776546117064;48681.26978095331;48803.267950980764;49469.50530494721;8678.646618041928;8682.34882383811;8696.17386348296;8810.712777322353;8901.421407608485;33617.32765344728;33737;33942.321153577286;34474;35028;41248;43756;44326;44353.33469998017;44377.33433998557;10484.947575262075;10580.735481613021;10728.839067414152;10846.783064338826;11124.61063862761;12217.328046957502;12234.265944043385;12268.202566833128;12449.439775209956;13679.79480307816;12875.935620321838;13142.145760525535;13184.208947463183;13220.471181152647;13996.16023038621;13286.13534074164;13335.399907004014;13352.857685464794;13567.728645427234;13848.515301964382;13171.341432928506;13308.134971226838;13434.261115638734;13481.797773033217;13534.052616316763;10825.188110891557;10856.2400631955;11031.503582338653;11106.555737770399;11287.266327689002;10231.744206394602;10273.640422585173;10301.278910476194;10898.8393365923;11016.283941543774 21:49:19 INFO - PROCESS | 3372 | __end_tp_report 21:49:19 INFO - PROCESS | 3372 | __start_cc_report 21:49:19 INFO - PROCESS | 3372 | _x_x_mozilla_cycle_collect,823 21:49:19 INFO - PROCESS | 3372 | __end_cc_report 21:49:19 INFO - PROCESS | 3372 | __startTimestamp1461559759023__endTimestamp 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | ------- Summary: start ------- 21:49:19 INFO - PROCESS | 3372 | Number of tests: 6 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | [#0] dojo.html Cycles:165 Average:5254.78 Median:5470.96 stddev:587.53 (10.7%) stddev-sans-first:564.22 21:49:19 INFO - PROCESS | 3372 | Values: 3088.3 3139.6 3177.2 3186.9 3206.8 5238.2 5249.5 5266.8 5277.2 5293.6 5302.7 5330.8 5334.7 5336.7 5350.2 4740.6 4792.0 4901.3 4937.4 4968.4 4867.1 4882.7 4908.5 4922.2 4923.4 4688.0 4690.3 4699.1 4789.7 4807.0 4710.6 4723.8 4730.1 4731.5 4754.6 4699.2 4702.9 4726.3 4736.1 4769.3 5147.9 5187.8 5219.4 5248.8 5258.3 5658.7 5674.2 5682.4 5686.7 5692.2 5590.6 5658.4 5727.0 5731.9 5733.0 5318.9 5363.4 5368.1 5375.3 5377.5 5834.6 5835.5 5838.2 5846.3 5846.8 5469.4 5532.9 5600.9 5617.0 5628.8 5605.4 5611.7 5621.2 5631.7 5692.3 5612.7 5616.4 5620.0 5626.3 5630.4 5540.2 5628.5 5649.3 5728.1 5762.9 4303.2 4304.1 4306.9 4307.9 4336.9 3837.3 3863.2 3868.8 3882.2 3888.8 5270.6 5299.0 5340.1 5361.7 5393.7 5630.6 5631.8 5648.1 5649.5 5658.4 5264.1 5293.3 5324.7 5336.2 5384.4 4855.4 4874.5 4880.0 4930.0 4930.4 5849.7 5866.4 5869.6 5871.6 5873.7 5574.9 5671.3 5706.3 5707.3 5743.1 5787.9 5797.9 5808.4 5818.7 5831.4 5491.6 5493.9 5495.9 5500.4 5546.6 5572.1 5604.6 5627.3 5637.5 5726.2 5537.3 5540.6 5561.0 5575.5 5589.3 5487.8 5493.2 5499.2 5504.9 5516.3 5367.7 5424.4 5427.1 5507.4 5511.8 5552.1 5571.5 5588.7 5589.0 5609.9 5461.9 5462.7 5469.2 5471.0 5479.1 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | [#1] ext.html Cycles:180 Average:60119.76 Median:40747.99 stddev:116870.01 (286.8%) stddev-sans-first:117112.40 21:49:19 INFO - PROCESS | 3372 | Values: 593.5 622.1 639.5 644.5 660.4 31767.0 32509.0 36976.6 38202.4 38308.4 40901.2 41694.0 41703.4 41747.2 41814.0 8425.2 8566.1 8625.1 8630.8 8637.0 8481.8 8608.0 8611.7 8612.4 8616.7 8830.3 8906.0 8909.2 8912.3 8913.2 8795.0 8868.3 8872.0 8877.9 8885.0 8664.7 8736.7 8765.7 8776.3 8778.4 39773.0 40730.8 40765.2 40767.6 40813.4 3351.6 3442.5 4014.3 4114.3 4155.4 30429.5 30956.0 31256.4 31346.5 32384.5 3799.5 3820.6 3889.6 3981.6 4139.4 455249.0 463767.4 464225.0 465464.0 465590.0 57870.4 58072.4 58346.1 58391.1 58402.7 62731.0 63877.7 64293.7 64478.4 64500.4 14932.9 15214.5 15220.8 15222.5 15234.8 10945.1 10946.5 10972.5 10975.3 10991.5 18594.9 18602.9 18764.6 19244.2 19374.5 7093.5 7213.8 7284.6 7332.9 7335.0 1024.9 1047.7 1112.7 1131.7 1189.4 30769.5 32128.0 32271.8 32275.7 32528.7 1101.1 1136.3 1144.9 1149.1 1151.7 16869.3 17220.1 17347.4 17422.4 17455.8 440234.0 446415.0 448159.0 448498.0 450524.0 56777.1 58314.0 58315.4 58457.7 58476.4 1349.4 1362.4 1387.7 1406.4 1410.6 27618.3 30739.4 32172.8 33422.5 36427.3 56871.7 57610.4 57960.0 57978.4 58015.1 411891.0 412227.0 413182.0 417289.0 417517.0 35693.6 37011.6 43148.4 43775.0 43866.3 41728.2 41891.6 42492.0 42581.0 43001.0 37379.3 39740.0 39992.8 40348.8 40660.6 38351.0 39524.0 39533.0 39559.0 39978.2 39503.6 39776.6 40214.4 40218.2 40235.4 33706.7 34088.3 34990.5 35096.8 35335.1 26981.7 27160.7 27447.5 27622.6 27658.4 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | [#2] jquery.html Cycles:180 Average:28806.74 Median:17692.54 stddev:76078.55 (430.0%) stddev-sans-first:76262.06 21:49:19 INFO - PROCESS | 3372 | Values: 393.0 393.7 398.6 400.9 408.6 16946.9 17810.0 18048.0 18236.5 18272.3 17472.6 17665.6 18227.6 18609.3 18664.3 5640.5 5699.8 5742.1 5793.1 5816.2 5554.5 5672.4 5729.9 5770.1 5772.1 5552.7 5675.2 5686.3 5692.8 5919.3 5864.6 5875.0 5878.8 5882.1 5913.9 5548.1 5706.3 5720.9 5741.5 5754.4 13678.7 13888.2 13888.7 24130.2 25413.4 2460.8 2565.4 2679.7 2779.2 2989.6 14313.3 15593.8 15725.7 15845.7 16128.1 2078.1 2180.1 2182.8 2224.3 2246.4 87166.0 89174.0 90186.0 90633.5 92187.0 17060.0 17385.9 17401.8 17742.5 17743.6 31705.4 31821.0 31953.5 31971.8 32129.5 9183.3 9297.8 9392.1 9489.8 9725.4 7678.3 7739.8 7851.2 7867.3 7874.1 8655.6 8733.7 8817.8 8959.9 9038.3 3104.2 3255.6 3470.0 3472.2 3492.0 869.4 1006.2 1007.4 1061.3 1062.2 18383.6 19170.9 19216.0 19219.2 19278.2 1025.0 1039.4 1042.5 1049.3 1121.6 10421.8 10701.5 10732.6 10957.6 10960.2 447565.0 455586.0 462106.0 466740.0 468293.0 84035.0 93242.0 93354.1 93368.5 93732.5 1033.0 1036.7 1100.1 1103.6 1121.3 16465.8 16728.9 16880.2 17071.4 17301.6 37045.0 37123.8 38774.6 38914.2 39222.0 48735.3 49128.0 56954.0 57420.1 58058.0 8183.9 8301.2 8411.8 8590.0 8664.2 9392.2 11413.8 11786.8 12153.0 12477.8 7329.9 11201.3 11346.5 11481.0 11643.5 11098.7 11101.5 11133.8 11199.0 11269.8 6367.0 8859.6 11320.5 11393.8 11475.5 8194.4 8202.1 8292.3 8330.1 8391.0 10816.9 11040.7 11203.9 11326.1 11350.5 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | [#3] mootools.html Cycles:180 Average:5589.39 Median:5035.03 stddev:3070.78 (61.0%) stddev-sans-first:3063.14 21:49:19 INFO - PROCESS | 3372 | Values: 1386.4 1489.3 1519.5 1693.0 1815.8 8065.1 8412.7 8413.7 8418.7 8427.6 8191.2 8353.2 8358.9 8360.7 8378.1 2075.6 2282.9 2316.9 2348.2 2361.1 2207.1 2233.2 2235.8 2239.5 2241.9 2252.3 2310.6 2317.5 2317.7 2321.1 2042.9 2215.4 2272.1 2277.7 2283.3 2204.8 2211.8 2214.6 2218.6 2291.3 8112.2 8265.8 8281.5 8297.3 8299.3 4901.6 5032.2 5075.2 5089.6 5140.8 3320.8 3385.1 3425.7 3446.6 3453.2 1174.0 1200.7 1210.5 1228.9 1233.6 10892.5 10913.2 10931.0 10931.4 10936.5 4332.6 4334.9 4515.7 4569.6 4587.5 9482.8 9489.4 9495.5 9508.4 9508.7 4678.5 5037.8 5042.0 5047.0 5064.8 4700.8 4783.5 4789.1 4795.1 4816.1 3863.3 3894.5 3942.1 3996.6 3997.5 1279.1 1289.4 1310.1 1314.0 1324.5 914.2 1009.3 1009.5 1021.1 1028.0 6092.5 6095.6 6142.9 6223.0 6242.8 462.1 462.3 472.1 478.9 482.4 4254.7 4279.9 4308.5 4309.3 4321.1 9938.4 10209.2 10463.8 10480.0 10483.4 10212.9 10310.7 10315.4 10357.3 10386.8 7605.5 7816.4 7962.4 7967.5 7978.5 5863.5 5994.8 6004.3 6054.0 6089.7 9296.5 9422.7 9464.4 9475.1 9560.7 9444.2 9755.1 9778.4 9885.5 9920.7 6994.9 7299.1 7470.4 7603.6 7748.8 8311.0 8322.8 8381.8 8403.3 8422.0 7464.7 7561.2 7651.2 7685.6 7710.5 7342.7 7374.8 7445.0 7460.7 7549.3 6816.6 6828.7 6881.9 6894.3 6897.0 5075.7 5082.1 5289.8 5314.9 5336.3 5319.4 5323.3 5361.2 5385.7 5424.8 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | [#4] prototype.html Cycles:180 Average:4923.12 Median:5559.51 stddev:1451.64 (26.1%) stddev-sans-first:1413.94 21:49:19 INFO - PROCESS | 3372 | Values: 316.9 332.8 335.9 336.7 337.9 5392.8 5452.5 5541.5 5574.6 5617.0 5461.3 5513.8 5524.4 5528.8 5530.5 4303.0 4304.2 4305.1 4315.2 4323.1 4226.6 4288.2 4288.5 4293.8 4324.1 4238.9 4242.2 4272.0 4277.8 4283.0 4277.4 4284.8 4286.9 4292.3 4300.8 3663.9 3796.4 3809.4 3816.5 3816.9 5303.0 5317.3 5324.2 5341.4 5342.2 4919.5 4958.9 4977.6 4980.3 4987.0 5633.4 5769.4 5774.0 5810.3 5874.1 4211.1 4226.6 4239.7 4240.7 4245.1 5730.6 5814.4 6021.9 6046.7 6074.7 4282.5 4285.7 4293.5 4299.5 4316.5 4318.7 4347.5 4357.9 4360.5 4374.5 4696.3 4713.3 4883.9 4924.1 5000.2 5823.6 5860.6 5881.3 5887.6 5891.4 1506.1 1518.5 1527.5 1528.8 1535.4 1012.2 1039.0 1059.3 1063.3 1069.6 5541.6 5544.4 5591.0 5593.9 5595.7 5960.3 5976.9 5981.0 5981.6 5985.9 5369.7 5599.9 5613.8 5620.9 5641.3 3185.8 3204.5 3223.2 3223.4 3228.5 5962.1 6235.7 6246.4 6252.3 6289.2 6145.6 6153.8 6160.4 6190.3 6190.5 6233.9 6251.8 6265.4 6271.9 6272.9 5825.9 6094.8 6102.6 6109.6 6113.5 5979.8 6014.4 6024.9 6040.8 6042.4 5978.3 6083.7 6244.3 6252.8 6279.0 4207.4 4224.6 4226.1 4230.9 4241.9 5909.5 6052.3 6057.1 6060.2 6080.6 5899.2 5911.7 5915.7 5928.6 5944.4 5908.6 5909.5 5919.5 5922.4 5926.3 5666.5 5785.5 5809.4 5834.4 5836.6 5877.7 5923.2 5935.4 5938.7 5940.3 5708.3 5757.2 5802.2 5817.2 5829.5 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - PROCESS | 3372 | [#5] yui.html Cycles:180 Average:14748.64 Median:4446.14 stddev:16804.54 (378.0%) stddev-sans-first:16819.14 21:49:19 INFO - PROCESS | 3372 | Values: 822.8 834.4 846.7 863.6 875.4 14159.9 14737.0 14765.8 14775.9 14786.9 15102.7 15147.8 15157.2 15171.4 15254.3 686.6 791.7 810.7 819.8 826.1 821.7 824.7 824.9 825.2 825.9 861.1 864.7 864.9 865.4 866.6 710.1 834.8 856.8 856.9 857.1 625.8 625.9 627.1 627.1 627.5 14476.7 14573.6 14646.5 14663.7 14670.3 13543.1 13757.0 13840.7 13905.2 14010.2 11472.0 11594.2 11770.9 11991.5 12107.0 3866.3 3904.1 3907.0 3960.6 4019.2 54950.5 55163.7 55278.0 55510.4 55871.0 10422.7 10507.2 10710.2 10718.4 10803.2 19359.1 19518.8 19614.6 19615.8 19631.8 7887.8 7990.2 8009.9 8161.1 8330.1 4606.7 4643.6 4662.5 4679.5 4688.2 3409.8 3448.7 3452.5 3459.0 3459.4 595.6 608.8 615.3 617.9 656.2 661.1 708.7 724.9 752.4 758.8 9264.2 9272.8 9362.5 9374.9 9514.5 534.8 604.5 637.2 703.3 716.2 4442.9 4449.4 4494.3 4573.3 4575.5 59906.4 60034.4 61967.7 62073.7 62544.0 52383.7 54097.2 54968.5 55263.7 56052.7 44612.8 44690.8 48681.3 48803.3 49469.5 8678.6 8682.3 8696.2 8810.7 8901.4 33617.3 33737.0 33942.3 34474.0 35028.0 41248.0 43756.0 44326.0 44353.3 44377.3 10484.9 10580.7 10728.8 10846.8 11124.6 12217.3 12234.3 12268.2 12449.4 13679.8 12875.9 13142.1 13184.2 13220.5 13996.2 13286.1 13335.4 13352.9 13567.7 13848.5 13171.3 13308.1 13434.3 13481.8 13534.1 10825.2 10856.2 11031.5 11106.6 11287.3 10231.7 10273.6 10301.3 10898.8 11016.3 21:49:19 INFO - PROCESS | 3372 | -------- Summary: end -------- 21:49:19 INFO - PROCESS | 3372 | 21:49:19 INFO - TEST-INFO | 3372: exit 0 21:49:19 INFO - TEST-OK | dromaeo_css | took 1117659ms 21:49:19 INFO - TEST-START | kraken 21:49:19 INFO - operating with platform_type : linux_ 21:49:19 INFO - Initialising browser for kraken test... 21:49:19 INFO - TEST-INFO | started process 3556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ymkIb/profile http://localhost:37665/getInfo.html) 21:49:24 INFO - PROCESS | 3556 | __metrics Screen width/height:1600/1200 21:49:24 INFO - PROCESS | 3556 | colorDepth:24 21:49:24 INFO - PROCESS | 3556 | Browser inner width/height: 1024/697 21:49:24 INFO - PROCESS | 3556 | __metrics 21:49:25 ERROR - PROCESS | 3556 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:49:26 INFO - TEST-INFO | 3556: exit 0 21:49:26 INFO - Browser initialized. 21:49:26 INFO - Running cycle 1/1 for kraken test... 21:49:26 INFO - TEST-INFO | started process 3636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ymkIb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:37 INFO - PROCESS | 3636 | RSS: Main: 153513984 21:49:37 INFO - PROCESS | 3636 | 21:49:40 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-beat-detection) 21:49:41 INFO - PROCESS | 3636 | RSS: Main: 208900096 21:49:41 INFO - PROCESS | 3636 | 21:49:43 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-dft) 21:49:44 INFO - PROCESS | 3636 | RSS: Main: 196317184 21:49:44 INFO - PROCESS | 3636 | 21:49:47 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-fft) 21:49:48 INFO - PROCESS | 3636 | RSS: Main: 265199616 21:49:48 INFO - PROCESS | 3636 | 21:49:50 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-oscillator) 21:49:50 INFO - PROCESS | 3636 | RSS: Main: 173764608 21:49:50 INFO - PROCESS | 3636 | 21:49:53 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37665/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:49:53 INFO - PROCESS | 3636 | RSS: Main: 178229248 21:49:53 INFO - PROCESS | 3636 | 21:49:56 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37665/tests/kraken/driver.html?testName=imaging-darkroom) 21:49:57 INFO - PROCESS | 3636 | RSS: Main: 214478848 21:49:57 INFO - PROCESS | 3636 | 21:50:00 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37665/tests/kraken/driver.html?testName=imaging-desaturate) 21:50:01 INFO - PROCESS | 3636 | RSS: Main: 214958080 21:50:01 INFO - PROCESS | 3636 | 21:50:04 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37665/tests/kraken/driver.html?testName=json-parse-financial) 21:50:04 INFO - PROCESS | 3636 | RSS: Main: 214974464 21:50:04 INFO - PROCESS | 3636 | 21:50:06 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37665/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:50:06 INFO - PROCESS | 3636 | RSS: Main: 200855552 21:50:06 INFO - PROCESS | 3636 | 21:50:08 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:50:09 INFO - PROCESS | 3636 | RSS: Main: 206249984 21:50:09 INFO - PROCESS | 3636 | 21:50:12 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:50:12 INFO - PROCESS | 3636 | RSS: Main: 215179264 21:50:12 INFO - PROCESS | 3636 | 21:50:15 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:50:15 INFO - PROCESS | 3636 | RSS: Main: 222998528 21:50:15 INFO - PROCESS | 3636 | 21:50:18 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:50:19 INFO - PROCESS | 3636 | RSS: Main: 219955200 21:50:19 INFO - PROCESS | 3636 | 21:50:20 INFO - PROCESS | 3636 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37665/tests/kraken/driver.html?testName=ai-astar) 21:50:21 INFO - PROCESS | 3636 | RSS: Main: 284086272 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | __start_tp_report 21:50:21 INFO - PROCESS | 3636 | _x_x_mozilla_page_load 21:50:21 INFO - PROCESS | 3636 | _x_x_mozilla_page_load_details 21:50:21 INFO - PROCESS | 3636 | |i|pagename|runs| 21:50:21 INFO - PROCESS | 3636 | |0;ai-astar;109;112;106;111;111;111;100;110;110;109 21:50:21 INFO - PROCESS | 3636 | |1;audio-beat-detection;157;128;155;176;128;153;162;130;187;134 21:50:21 INFO - PROCESS | 3636 | |2;audio-dft;160;160;161;160;159;160;159;162;161;162 21:50:21 INFO - PROCESS | 3636 | |3;audio-fft;72;73;116;114;76;76;72;127;101;72 21:50:21 INFO - PROCESS | 3636 | |4;audio-oscillator;92;93;156;93;93;92;156;93;92;144 21:50:21 INFO - PROCESS | 3636 | |5;imaging-gaussian-blur;116;117;117;116;117;117;116;116;117;117 21:50:21 INFO - PROCESS | 3636 | |6;imaging-darkroom;145;146;145;145;146;146;145;145;146;145 21:50:21 INFO - PROCESS | 3636 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 21:50:21 INFO - PROCESS | 3636 | |8;json-parse-financial;58;56;56;56;57;56;57;82;54;55 21:50:21 INFO - PROCESS | 3636 | |9;json-stringify-tinderbox;60;61;61;60;61;61;61;61;61;61 21:50:21 INFO - PROCESS | 3636 | |10;stanford-crypto-aes;77;77;78;76;75;76;78;79;79;80 21:50:21 INFO - PROCESS | 3636 | |11;stanford-crypto-ccm;127;126;130;124;131;120;123;123;159;130 21:50:21 INFO - PROCESS | 3636 | |12;stanford-crypto-pbkdf2;169;174;173;167;172;168;178;169;173;173 21:50:21 INFO - PROCESS | 3636 | |13;stanford-crypto-sha256-iterative;70;70;68;68;67;68;69;67;68;66 21:50:21 INFO - PROCESS | 3636 | __end_tp_report 21:50:21 INFO - PROCESS | 3636 | __start_cc_report 21:50:21 INFO - PROCESS | 3636 | _x_x_mozilla_cycle_collect,1609 21:50:21 INFO - PROCESS | 3636 | __end_cc_report 21:50:21 INFO - PROCESS | 3636 | __startTimestamp1461559821204__endTimestamp 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | ------- Summary: start ------- 21:50:21 INFO - PROCESS | 3636 | Number of tests: 14 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.54 (3.2%) stddev-sans-first:3.76 21:50:21 INFO - PROCESS | 3636 | Values: 109.0 112.0 106.0 111.0 111.0 111.0 100.0 110.0 110.0 109.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:156.00 stddev:20.78 (13.3%) stddev-sans-first:21.93 21:50:21 INFO - PROCESS | 3636 | Values: 157.0 128.0 155.0 176.0 128.0 153.0 162.0 130.0 187.0 134.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 21:50:21 INFO - PROCESS | 3636 | Values: 160.0 160.0 161.0 160.0 159.0 160.0 159.0 162.0 161.0 162.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#3] audio-fft Cycles:10 Average:89.90 Median:72.00 stddev:22.10 (30.7%) stddev-sans-first:22.47 21:50:21 INFO - PROCESS | 3636 | Values: 72.0 73.0 116.0 114.0 76.0 76.0 72.0 127.0 101.0 72.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.50 stddev:28.90 (31.2%) stddev-sans-first:29.87 21:50:21 INFO - PROCESS | 3636 | Values: 92.0 93.0 156.0 93.0 93.0 92.0 156.0 93.0 92.0 144.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:50:21 INFO - PROCESS | 3636 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:50:21 INFO - PROCESS | 3636 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:50:21 INFO - PROCESS | 3636 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:56.50 stddev:8.26 (14.6%) stddev-sans-first:8.76 21:50:21 INFO - PROCESS | 3636 | Values: 58.0 56.0 56.0 56.0 57.0 56.0 57.0 82.0 54.0 55.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 21:50:21 INFO - PROCESS | 3636 | Values: 60.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:1.58 (2.0%) stddev-sans-first:1.67 21:50:21 INFO - PROCESS | 3636 | Values: 77.0 77.0 78.0 76.0 75.0 76.0 78.0 79.0 79.0 80.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:128.50 stddev:11.04 (8.6%) stddev-sans-first:11.67 21:50:21 INFO - PROCESS | 3636 | Values: 127.0 126.0 130.0 124.0 131.0 120.0 123.0 123.0 159.0 130.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:173.00 stddev:3.34 (1.9%) stddev-sans-first:3.41 21:50:21 INFO - PROCESS | 3636 | Values: 169.0 174.0 173.0 167.0 172.0 168.0 178.0 169.0 173.0 173.0 21:50:21 INFO - PROCESS | 3636 | 21:50:21 INFO - PROCESS | 3636 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.17 21:50:21 INFO - PROCESS | 3636 | Values: 70.0 70.0 68.0 68.0 67.0 68.0 69.0 67.0 68.0 66.0 21:50:21 INFO - PROCESS | 3636 | -------- Summary: end -------- 21:50:21 INFO - PROCESS | 3636 | 21:50:22 INFO - TEST-INFO | 3636: exit 0 21:50:22 INFO - TEST-OK | kraken | took 62416ms 21:50:22 INFO - SUITE-END | took 1180s 21:50:22 INFO - Completed test suite (00:19:40) 21:50:22 INFO - javascript benchmark 21:50:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.289693370524, 3139.591853059102, 3177.1580531159248, 3186.920326991825, 3206.759493038022, 5238.214267859823, 5249.527542521172, 5266.76299566519, 5277.182036784295, 5293.602979776518, 5302.708351040691, 5330.813421530247, 5334.67991920485, 5336.706481143536, 5350.224217488462, 4740.644451666121, 4792.04159168166, 4901.338319326881, 4937.358143441347, 4968.428630707479, 4867.13314594423, 4882.658213925027, 4908.533689299528, 4922.237053256733, 4923.409190897098, 4687.976560117195, 4690.319903613991, 4699.0836786826585, 4789.664723469358, 4806.95193048072, 4710.62315014798, 4723.7874295656775, 4730.053989202139, 4731.4795372509, 4754.643401744848, 4699.2481203007355, 4702.858914232578, 4726.291056341542, 4736.076465089309, 4769.260764581495, 5147.871303217412, 5187.792488300463, 5219.373675159005, 5248.8425347239645, 5258.316418865561, 5658.7170641467765, 5674.2339784129435, 5682.431756824326, 5686.658800471985, 5692.203091567184, 5590.5527557795685, 5658.405867383948, 5726.9713651431475, 5731.942680573225, 5733.0, 5318.946810531884, 5363.410024897258, 5368.087425137697, 5375.3280839895015, 5377.46225377463, 5834.5624078194305, 5835.503982161479, 5838.153467747238, 5846.269216347957, 5846.766129354864, 5469.371022332403, 5532.944670553324, 5600.85997850057, 5616.971915140398, 5628.774849006076, 5605.411431799684, 5611.663300202001, 5621.241132447068, 5631.7184140793615, 5692.345380281238, 5612.719364031864, 5616.438356164351, 5620.016497112989, 5626.324841019104, 5630.352509461464, 5540.196671482612, 5628.493435590816, 5649.265595472562, 5728.112142617901, 5762.94237057624, 4303.182395344875, 4304.096139810612, 4306.935395969063, 4307.892302692395, 4336.891577710519, 3837.2517359114704, 3863.2273545291055, 3868.787216703052, 3882.2235552889533, 3888.844446222176, 5270.631055826132, 5299.046171689133, 5340.06548853949, 5361.651492652965, 5393.703346315911, 5630.60585758993, 5631.774729010794, 5648.124540696199, 5649.519790817744, 5658.377578466366, 5264.052470555337, 5293.311869457023, 5324.733763311819, 5336.17289320156, 5384.353877534642, 4855.44162421319, 4874.46380898101, 4880.0, 4929.950700493021, 4930.359053323045, 5849.707514624251, 5866.384029676908, 5869.589128761031, 5871.64770113786, 5873.676947767914, 5574.91637625444, 5671.262735844314, 5706.28671416073, 5707.343655479673, 5743.0811070228565, 5787.94212057874, 5797.91303130445, 5808.448197421239, 5818.679972601378, 5831.446012628793, 5491.615586908878, 5493.945060549343, 5495.890082198253, 5500.367457742411, 5546.639468434539, 5572.108462645957, 5604.607677462702, 5627.324721033502, 5637.520810731134, 5726.2269593606, 5537.307836520435, 5540.63985840919, 5561.0, 5575.470330318613, 5589.329280486368, 5487.835364939058, 5493.23094766725, 5499.202615620633, 5504.862378440571, 5516.255305533701, 5367.651102678314, 5424.430434804446, 5427.104527753035, 5507.421720719267, 5511.751971161388, 5552.056150454352, 5571.470710282517, 5588.692621905834, 5588.972055139699, 5609.915851262316, 5461.863453413696, 5462.726863656721, 5469.179623056414, 5470.960517501662, 5479.123340265538], "value": 5216.187410491384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4540222994844, 622.1445512420422, 639.5107742576927, 644.4683136412461, 660.3759447322279, 31767.0, 32509.02472925813, 36976.63023369765, 38202.4269635955, 38308.425373619415, 40901.18197636046, 41694.0, 41703.374449383286, 41747.16505669885, 41814.0, 8425.199606037417, 8566.100559441262, 8625.094365091669, 8630.784230394227, 8636.956815215915, 8481.787955301135, 8608.0, 8611.741647750578, 8612.39713220075, 8616.65533378664, 8830.337724670675, 8906.020337762873, 8909.153630405133, 8912.331575131859, 8913.153250441197, 8795.0, 8868.290536757044, 8872.0, 8877.866831997526, 8884.955575222082, 8664.740057798275, 8736.737897863075, 8765.685147227903, 8776.254018408443, 8778.385513014091, 39773.0, 40730.796346018375, 40765.184696306205, 40767.59232407668, 40813.38779918304, 3351.6145643251093, 3442.4836274558766, 4014.2774300625874, 4114.341705327133, 4155.4182414462, 30429.543556846664, 30956.0, 31256.37487250265, 31346.529802052988, 32384.5142322863, 3799.4870692456716, 3820.59883712209, 3889.630485103939, 3981.6416522513114, 4139.379093136024, 455249.0, 463767.36232637917, 464225.0, 465464.0, 465590.0, 57870.421295787346, 58072.419275807544, 58346.12480812791, 58391.12413313804, 58402.7079864598, 62731.0, 63877.68061159665, 64293.678531607045, 64478.35521644817, 64500.354996450376, 14932.850671493146, 15214.543563693107, 15220.771688424682, 15222.46721364747, 15234.771478427832, 10945.069669078217, 10946.507407166697, 10972.451377431096, 10975.28660637056, 10991.505382257817, 18594.907025464785, 18602.906985464986, 18764.624707505773, 19244.23023079061, 19374.51258773434, 7093.503454758117, 7213.799791063671, 7284.579506996085, 7332.8900066499045, 7334.96332518334, 1024.8872624011353, 1047.696168111239, 1112.710695219249, 1131.671815173607, 1189.4409627475072, 30769.538456923165, 32128.0, 32271.838640807116, 32275.677243227736, 32528.674713253036, 1101.1411099342527, 1136.2557524821254, 1144.9198556100994, 1149.0635132367095, 1151.7408583068743, 16869.32522699103, 17220.1389930503, 17347.392841250497, 17422.390216342366, 17455.770682423794, 440234.0, 446415.0, 448159.0, 448498.0, 450524.0, 56777.14834277407, 58314.0, 58315.416845831845, 58457.70771146117, 58476.41523584795, 1349.413005342679, 1362.434589645286, 1387.6808334083016, 1406.381192275416, 1410.6261840612246, 27618.309542261602, 30739.385212295183, 32172.83913580511, 33422.49866252057, 36427.27145457129, 56871.71564142153, 57610.423895760505, 57960.0, 57978.420215797305, 58015.12977305259, 411891.0, 412227.0, 413182.0, 417289.0, 417517.0, 35693.64306357007, 37011.61300577156, 43148.352774707775, 43775.0, 43866.34200487059, 41728.16543669171, 41891.581084188765, 42492.0, 42581.0, 43001.0, 37379.25241495209, 39740.0, 39992.80003599964, 40348.79825600853, 40660.59339406568, 38351.0, 39524.0, 39533.0, 39559.0, 39978.2004359917, 39503.60496394999, 39776.60223397729, 40214.396784047676, 40218.1956360877, 40235.39646905357, 33706.66293337035, 34088.318233635684, 34990.47514287237, 35096.824515877255, 35335.11662208466, 26981.730182698706, 27160.72839271582, 27447.45105097847, 27622.5856612155, 27658.44683106367], "value": 20002.63520163656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.9646331830136, 393.71849127873566, 398.63325740318913, 400.9258287216865, 408.6016134269088, 16946.91526542367, 17810.0, 18048.0, 18236.45290641281, 18272.269109235633, 17472.563185920357, 17665.55836104098, 18227.635447291046, 18609.255629774794, 18664.253429862823, 5640.520555752766, 5699.829005129853, 5742.052561327376, 5793.13103034544, 5816.243888294516, 5554.50009499145, 5672.40439753824, 5729.885402291951, 5770.105633626774, 5772.134179873011, 5552.694601796899, 5675.233843431146, 5686.289213848269, 5692.829215123532, 5919.319278282988, 5864.5894787364905, 5875.0, 5878.794242201545, 5882.117682347639, 5913.940860591403, 5548.056830338852, 5706.343770466408, 5720.856978575569, 5741.45456181662, 5754.424557544254, 13678.726425471436, 13888.23614701191, 13888.652783680387, 24130.155444559357, 25413.364665883317, 2460.8400453970435, 2565.3586603349163, 2679.6918354389104, 2779.1523585306472, 2989.5814585957764, 14313.284335783273, 15593.844061559352, 15725.685486290211, 15845.651469451923, 16128.112953787537, 2078.147959336665, 2180.0843645668856, 2182.792634699717, 2224.265992222579, 2246.449619843149, 87166.0, 89174.0, 90186.0, 90633.54683226542, 92187.0, 17060.0, 17385.913070434566, 17401.825981740272, 17742.467725968243, 17743.55641108957, 31705.36589268248, 31821.0, 31953.52069718956, 31971.840140799148, 32129.51805722916, 9183.311251656152, 9297.814043719087, 9392.107749763762, 9489.810203795885, 9725.367851089657, 7678.347340476123, 7739.7678069658, 7851.214878512217, 7867.291943725092, 7874.125944030502, 8655.639845790325, 8733.694320698745, 8817.811539518805, 8959.865602015974, 9038.276937844958, 3104.221721559237, 3255.5604993325596, 3470.0, 3472.166679996833, 3491.9873236761055, 869.4261787220404, 1006.225206590921, 1007.3955626623967, 1061.3295438171058, 1062.1661995333625, 18383.632327353378, 19170.904145479184, 19216.0, 19219.231230750895, 19278.22887084529, 1025.0, 1039.3504059962524, 1042.4527123260198, 1049.2602715085998, 1121.6410748560381, 10421.791564168674, 10701.518431670438, 10732.570697172026, 10957.616483423042, 10960.232783705063, 447565.0, 455586.0, 462106.0, 466740.0, 468293.0, 84035.0, 93242.0, 93354.0664593359, 93368.53315733378, 93732.53133734288, 1033.0, 1036.7459972306833, 1100.114407901647, 1103.564092183599, 1121.3047910295668, 16465.753013705045, 16728.91635541863, 16880.155992200587, 17071.40250091241, 17301.56746081358, 37045.0, 37123.814380929005, 38774.61225387823, 38914.2217155661, 39222.0, 48735.26897096475, 49128.00967274959, 56954.0, 57420.13869791873, 58058.0, 8183.902992270796, 8301.211384918422, 8411.789705257417, 8590.01214860274, 8664.220220180214, 9392.248620110511, 11413.828792567952, 11786.823197652213, 12153.02775777918, 12477.75044499123, 7329.9267007329245, 11201.271917325348, 11346.546138154381, 11481.0, 11643.53425862956, 11098.66703998849, 11101.50043248072, 11133.777324453627, 11199.048080913213, 11269.830952535882, 6366.9681651591445, 8859.557022148738, 11320.547178112784, 11393.829092563785, 11475.48360323804, 8194.38542109356, 8202.138775428493, 8292.253697167283, 8330.083690794128, 8391.021187478602, 10816.945915270373, 11040.668779936615, 11203.88796112061, 11326.093912487146, 11350.489227984595], "value": 9823.842805353841, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.3830595385057, 1489.3000289863767, 1519.498565473394, 1692.983070169298, 1815.8274963878428, 8065.112837587868, 8412.66349346027, 8413.663453461853, 8418.663253469862, 8427.578621068946, 8191.180881911806, 8353.248207661309, 8358.874616880736, 8360.665573377057, 8378.078411374743, 2075.647139986206, 2282.851614645043, 2316.9073237070497, 2348.248560460653, 2361.067378385537, 2207.106122020576, 2233.1848875160613, 2235.8211343092594, 2239.5296987632537, 2241.8766967816846, 2252.2905284835306, 2310.6187479065934, 2317.5480781247666, 2317.6755254264417, 2321.106374045996, 2042.908069136885, 2215.4129155773735, 2272.0798076778933, 2277.6811246425514, 2283.3492454650345, 2204.834637402201, 2211.800937915595, 2214.55708858229, 2218.589560931233, 2291.346966114666, 8112.188781121899, 8265.752027439186, 8281.54451505167, 8297.25324720772, 8299.29455996241, 4901.632377571696, 5032.245163225509, 5075.21334193197, 5089.567386772129, 5140.794368225266, 3320.767546271762, 3385.1029477188563, 3425.6745609167087, 3446.552447971858, 3453.240287136826, 1173.976520469586, 1200.675817529271, 1210.5339444314002, 1228.8709685483075, 1233.5990802988974, 10892.509837057352, 10913.23607347486, 10931.0, 10931.398773067478, 10936.453177341102, 4332.610065094157, 4334.869953901325, 4515.661325400608, 4569.588737013618, 4587.518310577341, 9482.810343793224, 9489.430634161972, 9495.477748723748, 9508.381955172892, 9508.667196648084, 4678.485366609671, 5037.82367617139, 5041.991601679679, 5047.0, 5064.82273120439, 4700.788464519105, 4783.521647835259, 4789.114013907439, 4795.088933102699, 4816.084943860656, 3863.343231650626, 3894.5131858517684, 3942.1327307992196, 3996.6003399659803, 3997.4603428537357, 1279.1365828066018, 1289.4004288006122, 1310.0894878059657, 1313.9934300328628, 1324.536412255722, 914.1955079529971, 1009.3035805294323, 1009.5305682857506, 1021.0912288063629, 1027.9691609251734, 6092.482139018144, 6095.603785753912, 6142.938570614326, 6222.968885155546, 6242.843928901723, 462.1219682603014, 462.28115280738103, 472.091224393042, 478.85155601763563, 482.39700374531833, 4254.659627229814, 4279.850205242801, 4308.46144231971, 4309.332053531708, 4321.092570560218, 9938.354006989523, 10209.234307426972, 10463.84304235437, 10480.0, 10483.37099774016, 10212.897871021343, 10310.690679279634, 10315.432651204106, 10357.274990750575, 10386.767939236397, 7605.543667379975, 7816.374690024784, 7962.363010959225, 7967.521948683097, 7978.521288722695, 5863.472287494146, 5994.820155395345, 6004.279486461653, 6053.969730151497, 6089.725962331617, 9296.535173241176, 9422.670206542738, 9464.384814987005, 9475.147236748726, 9560.665376711782, 9444.244460443286, 9755.073268039525, 9778.364406313567, 9885.505724713592, 9920.652777152765, 6994.895076573957, 7299.124105107421, 7470.439717021354, 7603.619819009138, 7748.8450230996195, 8311.0, 8322.791930201793, 8381.832363352822, 8403.327733781161, 8422.0, 7464.701411943462, 7561.168271490022, 7651.234876512304, 7685.577293248702, 7710.537367757728, 7342.70629174827, 7374.778756637309, 7444.962775186089, 7460.66427010775, 7549.282818132268, 6816.591004539743, 6828.7268509259075, 6881.862362752817, 6894.276101009322, 6897.034415181979, 5075.720835354091, 5082.136036873666, 5289.841304760864, 5314.920276195783, 5336.279602253646, 5319.4414586467865, 5323.281357016908, 5361.24942508057, 5385.73071346439, 5424.83725488236], "value": 4461.5143107379445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.87325069971996, 332.78202777180945, 335.9049498634451, 336.725568661541, 337.93072420153857, 5392.757325920328, 5452.536534394576, 5541.473560011797, 5574.581906357029, 5616.971915140419, 5461.290032295806, 5513.807016754415, 5524.364698059724, 5528.806491772789, 5530.474604912537, 4302.956970430295, 4304.24675681756, 4305.117450922569, 4315.158544083905, 4323.1353729254115, 4226.556211597784, 4288.228118938589, 4288.463942007249, 4293.849715259951, 4324.07032488015, 4238.894027649302, 4242.236397448458, 4272.0, 4277.764722940237, 4283.0, 4277.379779931908, 4284.828606855722, 4286.935695964563, 4292.2917718576555, 4300.849470268541, 3663.8900832975055, 3796.373598356268, 3809.447630093621, 3816.484774555427, 3816.885493435201, 5303.0, 5317.335333083364, 5324.1747529133045, 5341.359036915556, 5342.171963345688, 4919.483454237289, 4958.900821983576, 4977.576905962997, 4980.327655766461, 4987.0, 5633.408492108351, 5769.423057694239, 5773.971130144364, 5810.327249465251, 5874.089516125007, 4211.115665710205, 4226.556211597799, 4239.745615263094, 4240.724352917051, 4245.10852720929, 5730.570207234432, 5814.418558144152, 6021.909671354933, 6046.667433291167, 6074.696265186767, 4282.464691913511, 4285.721428107163, 4293.484781826139, 4299.462567179103, 4316.5467625899455, 4318.676099292566, 4347.478302603708, 4357.891052723644, 4360.542143074995, 4374.540673229329, 4696.2955556666775, 4713.34013238147, 4883.853484395474, 4924.138275801721, 5000.174971129795, 5823.56323275756, 5860.560457965669, 5881.32364778056, 5887.587868849139, 5891.351951285355, 1506.1189204315378, 1518.5042732908078, 1527.5188315680525, 1528.8318284988643, 1535.4318902006105, 1012.1700205831148, 1038.9688309350731, 1059.2532264753331, 1063.2504084620325, 1069.5668254356997, 5541.612087153861, 5544.445555444423, 5590.972045139748, 5593.8601534961135, 5595.7481913313995, 5960.254968128984, 5976.880462390728, 5980.970095149496, 5981.611195272293, 5985.9401405986255, 5369.6509726867625, 5599.8600034998635, 5613.775448982076, 5620.887582248332, 5641.323041234996, 3185.8088514689193, 3204.4552426087157, 3223.1942014496376, 3223.3875563642832, 3228.4511633022444, 5962.135490353961, 6235.719392627343, 6246.407740787613, 6252.343503932022, 6289.150964619717, 6145.5698101133385, 6153.784617538365, 6160.445559899541, 6190.288116866528, 6190.511878887771, 6233.906491402633, 6251.812445626639, 6265.373462653698, 6271.905921411182, 6272.905906411316, 5825.94174058254, 6094.75620975156, 6102.633841969496, 6109.633421994695, 6113.480354169946, 5979.790707325223, 6014.398560143951, 6024.9397506026135, 6040.818775436744, 6042.3655516170165, 5978.252718410199, 6083.726232319467, 6244.313125556276, 6252.843678908063, 6279.0267508534425, 4207.389928460418, 4224.598663126998, 4226.13364260332, 4230.894227644333, 4241.893952651209, 5909.468147866713, 6052.334243233329, 6057.121717351048, 6060.2424696912885, 6080.604760690541, 5899.203607512931, 5911.733971971185, 5915.674637894785, 5928.584999050025, 5944.405559444021, 5908.556858235564, 5909.52723782105, 5919.496842768241, 5922.407759224043, 5926.288845338587, 5666.46168613981, 5785.450382213683, 5809.36097029318, 5834.38738932406, 5836.649801011953, 5877.676727780014, 5923.170756094064, 5935.436133567304, 5938.673372964528, 5940.346561878277, 5708.257926469532, 5757.157709533077, 5802.187693722798, 5817.156512305776, 5829.5336373090895], "value": 4460.415984517913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.8230930349976, 834.3867257565691, 846.7375113714747, 863.6243234193126, 875.3959767760241, 14159.858401415995, 14737.0, 14765.77851332231, 14775.926120369397, 14786.926065369686, 15102.697946041073, 15147.848521514781, 15157.242137893089, 15171.393144274243, 15254.313555889983, 686.5708931917552, 791.7387262203459, 810.6514198894473, 819.8114433680228, 826.0912995704707, 821.7288294862681, 824.72371755462, 824.9216324449168, 825.162460102996, 825.9091499935003, 861.130258438978, 864.7362554420899, 864.9308055355588, 865.4201684871151, 866.5927014303268, 710.0627172132787, 834.7579202031434, 856.8072183758667, 856.87146927961, 857.0743596915316, 625.809128215894, 625.9248890133167, 627.0594108836744, 627.0813258576162, 627.5418944170781, 14476.710465790731, 14573.6356591085, 14646.487372941896, 14663.70672586553, 14670.26648667573, 13543.119697219649, 13757.0, 13840.653983650389, 13905.235212063333, 14010.159390436607, 11472.0, 11594.188406811527, 11770.941145294219, 11991.460384282727, 12107.0, 3866.3427217372832, 3904.121572646132, 3906.980465097685, 3960.6237407446533, 4019.2363450944226, 54950.45049549533, 55163.724181379235, 55277.9999999996, 55510.44489555093, 55871.0, 10422.739431514121, 10507.159427245802, 10710.196735244888, 10718.35689858611, 10803.189760767973, 19359.12883920227, 19518.804811951984, 19614.607707845764, 19615.803841961682, 19631.803681963283, 7887.842243155104, 7990.240927111915, 8009.879851802111, 8161.143079976517, 8330.125336839666, 4606.677532572688, 4643.605293550018, 4662.487126416091, 4679.461861885927, 4688.203005489075, 3409.7613167078066, 3448.7241020718284, 3452.4993875887853, 3459.0487615905827, 3459.3773120837986, 595.6455908734296, 608.8477880529867, 615.2801222569605, 617.9165812615329, 656.2092678322609, 661.0876989754108, 708.6598432752307, 724.9166345870187, 752.4243953375671, 758.772368289511, 9264.166225039779, 9272.795705314913, 9362.485063321583, 9374.85937710935, 9514.476703781358, 534.7540131539457, 604.4590091867753, 637.209859773877, 703.3494018033299, 716.1549371741291, 4442.933355999663, 4449.354843547668, 4494.270843640558, 4573.268277075718, 4575.519570445055, 59906.400935990954, 60034.399656003756, 61967.690161548904, 62073.689631551555, 62544.0, 52383.73808131011, 54097.1885421719, 54968.45031549633, 55263.723681381336, 56052.71973640106, 44612.776936115115, 44690.776546117064, 48681.26978095331, 48803.267950980764, 49469.50530494721, 8678.646618041928, 8682.34882383811, 8696.17386348296, 8810.712777322353, 8901.421407608485, 33617.32765344728, 33737.0, 33942.321153577286, 34474.0, 35028.0, 41248.0, 43756.0, 44326.0, 44353.33469998017, 44377.33433998557, 10484.947575262075, 10580.735481613021, 10728.839067414152, 10846.783064338826, 11124.61063862761, 12217.328046957502, 12234.265944043385, 12268.202566833128, 12449.439775209956, 13679.79480307816, 12875.935620321838, 13142.145760525535, 13184.208947463183, 13220.471181152647, 13996.16023038621, 13286.13534074164, 13335.399907004014, 13352.857685464794, 13567.728645427234, 13848.515301964382, 13171.341432928506, 13308.134971226838, 13434.261115638734, 13481.797773033217, 13534.052616316763, 10825.188110891557, 10856.2400631955, 11031.503582338653, 11106.555737770399, 11287.266327689002, 10231.744206394602, 10273.640422585173, 10301.278910476194, 10898.8393365923, 11016.283941543774], "value": 6750.019490481297, "unit": "score"}], "name": "dromaeo_css", "value": 7186.018775899896, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 106.0, 111.0, 111.0, 111.0, 100.0, 110.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 155.0, 176.0, 128.0, 153.0, 162.0, 130.0, 187.0, 134.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 159.0, 162.0, 161.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 116.0, 114.0, 76.0, 76.0, 72.0, 127.0, 101.0, 72.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 156.0, 93.0, 93.0, 92.0, 156.0, 93.0, 92.0, 144.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 82.0, 54.0, 55.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 76.0, 75.0, 76.0, 78.0, 79.0, 79.0, 80.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 130.0, 124.0, 131.0, 120.0, 123.0, 123.0, 159.0, 130.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 173.0, 167.0, 172.0, 168.0, 178.0, 169.0, 173.0, 173.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 68.0, 67.0, 68.0, 69.0, 67.0, 68.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1543.4999999999995, "alertThreshold": 2.0}]} 21:50:22 INFO - Return code: 0 21:50:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:50:22 ERROR - # TBPL SUCCESS # 21:50:22 INFO - Running post-action listener: _resource_record_post_action 21:50:22 INFO - Running post-run listener: _resource_record_post_run 21:50:23 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7806976; Write bytes: 427982848; Read time: 2528; Write time: 594508 21:50:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15708160; Read time: 0; Write time: 12116 21:50:23 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 5939200; Write bytes: 412274688; Read time: 1712; Write time: 582392 21:50:23 INFO - Running post-run listener: _upload_blobber_files 21:50:23 INFO - Blob upload gear active. 21:50:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:50:23 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 21:50:23 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'] 21:50:23 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 21:50:23 INFO - (blobuploader) - INFO - Open directory for files ... 21:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:50:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:24 INFO - (blobuploader) - INFO - Done attempting. 21:50:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:50:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:25 INFO - (blobuploader) - INFO - Done attempting. 21:50:25 INFO - (blobuploader) - INFO - Iteration through files over. 21:50:25 INFO - Return code: 0 21:50:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:50:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:50:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/893fa0e95cdc0e276eb9b2fab6d03945ea755555a609eaa621087742048071c9317ab492da4afb727f6a0f32c8d3f6f260ae726fa03b21c044c0a42f4183695c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcb1727adcf324ffd6be4396c4c5e2f8b85c269305aa24487bf03cc562f147c91ccfaa06ca27a92915903a6c73e23d7719651c8fa14215be3863912487be8946"} 21:50:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:50:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:50:25 INFO - Contents: 21:50:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/893fa0e95cdc0e276eb9b2fab6d03945ea755555a609eaa621087742048071c9317ab492da4afb727f6a0f32c8d3f6f260ae726fa03b21c044c0a42f4183695c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcb1727adcf324ffd6be4396c4c5e2f8b85c269305aa24487bf03cc562f147c91ccfaa06ca27a92915903a6c73e23d7719651c8fa14215be3863912487be8946"} 21:50:25 INFO - Running post-run listener: copy_logs_to_upload_dir 21:50:25 INFO - Copying logs to upload dir... 21:50:25 INFO - mkdir: /builds/slave/test/build/upload/logs 21:50:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.938784 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-24 21:50:25.695717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:25.699316) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045 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/893fa0e95cdc0e276eb9b2fab6d03945ea755555a609eaa621087742048071c9317ab492da4afb727f6a0f32c8d3f6f260ae726fa03b21c044c0a42f4183695c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcb1727adcf324ffd6be4396c4c5e2f8b85c269305aa24487bf03cc562f147c91ccfaa06ca27a92915903a6c73e23d7719651c8fa14215be3863912487be8946"} build_url:https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/893fa0e95cdc0e276eb9b2fab6d03945ea755555a609eaa621087742048071c9317ab492da4afb727f6a0f32c8d3f6f260ae726fa03b21c044c0a42f4183695c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcb1727adcf324ffd6be4396c4c5e2f8b85c269305aa24487bf03cc562f147c91ccfaa06ca27a92915903a6c73e23d7719651c8fa14215be3863912487be8946"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:25.728368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:25.728884) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1461554048.392469-1607169045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:25.812729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 21:50:25.813175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 21:50:25.813856) ========= ========= Total master_lag: 0.18 =========