builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1463740298.19 results: success (0) buildid: 20160520004020 builduid: 5dfe1364884c48b6b304c6cb7a949a07 revision: 9ba18aae69e626a3f83560df321d91e42316083a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.193397) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.193888) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.194165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.210298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.210619) ========= 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=6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 03:31:38-- 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% 34.1M=0s 2016-05-20 03:31:38 (34.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115273 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.339471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.339802) ========= 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=6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015298 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.389538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:38.389979) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ba18aae69e626a3f83560df321d91e42316083a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ba18aae69e626a3f83560df321d91e42316083a --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=6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 03:31:38,891 truncating revision to first 12 chars 2016-05-20 03:31:38,891 Setting DEBUG logging. 2016-05-20 03:31:38,891 attempt 1/10 2016-05-20 03:31:38,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9ba18aae69e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 03:31:39,180 unpacking tar archive at: mozilla-aurora-9ba18aae69e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:39.003219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:39.003584) ========= script_repo_revision: 9ba18aae69e626a3f83560df321d91e42316083a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:39.004020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:39.004291) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 03:31:39.012928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-20 03:31:39.013247) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:39 INFO - MultiFileLogger online at 20160520 03:31:39 in /builds/slave/test 03:31:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:31:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:39 INFO - {'append_to_log': False, 03:31:39 INFO - 'base_work_dir': '/builds/slave/test', 03:31:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:39 INFO - 'branch': 'Mozilla-Aurora', 03:31:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:39 INFO - 'config_files': ('talos/linux_config.py',), 03:31:39 INFO - 'default_actions': ('clobber', 03:31:39 INFO - 'read-buildbot-config', 03:31:39 INFO - 'download-and-extract', 03:31:39 INFO - 'populate-webroot', 03:31:39 INFO - 'create-virtualenv', 03:31:39 INFO - 'install', 03:31:39 INFO - 'run-tests'), 03:31:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:39 INFO - 'download_minidump_stackwalk': True, 03:31:39 INFO - 'download_symbols': 'ondemand', 03:31:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:39 INFO - 'installer_path': 'installer.exe', 03:31:39 INFO - 'log_level': 'info', 03:31:39 INFO - 'log_name': 'talos', 03:31:39 INFO - 'log_to_console': True, 03:31:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:39 INFO - 'opt_config_files': (), 03:31:39 INFO - 'pip_index': False, 03:31:39 INFO - 'sps_profile': False, 03:31:39 INFO - 'sps_profile_interval': 0, 03:31:39 INFO - 'suite': 'dromaeojs', 03:31:39 INFO - 'system_bits': '32', 03:31:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:39 INFO - 'title': 'talos-linux64-ix-050', 03:31:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:39 INFO - 'use_talos_json': True, 03:31:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:39 INFO - 'work_dir': 'build'} 03:31:39 INFO - ##### 03:31:39 INFO - ##### Running clobber step. 03:31:39 INFO - ##### 03:31:39 INFO - Running pre-action listener: _resource_record_pre_action 03:31:39 INFO - Running main action method: clobber 03:31:39 INFO - rmtree: /builds/slave/test/build 03:31:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:40 INFO - Running post-action listener: _resource_record_post_action 03:31:40 INFO - ##### 03:31:40 INFO - ##### Running read-buildbot-config step. 03:31:40 INFO - ##### 03:31:40 INFO - Running pre-action listener: _resource_record_pre_action 03:31:40 INFO - Running main action method: read_buildbot_config 03:31:40 INFO - Using buildbot properties: 03:31:40 INFO - { 03:31:40 INFO - "project": "", 03:31:40 INFO - "product": "firefox", 03:31:40 INFO - "script_repo_revision": "production", 03:31:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:31:40 INFO - "repository": "", 03:31:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:31:40 INFO - "buildid": "20160520004020", 03:31:40 INFO - "stage_platform": "linux64-pgo", 03:31:40 INFO - "basedir": "/builds/slave/test", 03:31:40 INFO - "nightly_build": "True", 03:31:40 INFO - "buildnumber": 241, 03:31:40 INFO - "slavename": "talos-linux64-ix-050", 03:31:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:31:40 INFO - "platform": "ubuntu64_hw", 03:31:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:40 INFO - "branch": "mozilla-aurora", 03:31:40 INFO - "repo_path": "releases/mozilla-aurora", 03:31:40 INFO - "revision": "9ba18aae69e626a3f83560df321d91e42316083a", 03:31:40 INFO - "pgo_build": "True", 03:31:40 INFO - "builduid": "5dfe1364884c48b6b304c6cb7a949a07", 03:31:40 INFO - "slavebuilddir": "test" 03:31:40 INFO - } 03:31:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:31:40 INFO - Running post-action listener: _resource_record_post_action 03:31:40 INFO - ##### 03:31:40 INFO - ##### Running download-and-extract step. 03:31:40 INFO - ##### 03:31:40 INFO - Running pre-action listener: _resource_record_pre_action 03:31:40 INFO - Running main action method: download_and_extract 03:31:40 INFO - mkdir: /builds/slave/test/build/tests 03:31: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')]} 03:31:40 INFO - https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:40 INFO - Downloaded 1361 bytes. 03:31:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:40 INFO - Using the following test package requirements: 03:31:40 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:40 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:40 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:40 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'jsshell-linux-x86_64.zip'], 03:31:40 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:40 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:40 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:40 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:40 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:40 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31: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')]} 03:31:40 INFO - https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:41 INFO - Downloaded 23813397 bytes. 03:31:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:43 INFO - Return code: 0 03:31:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31:43 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')]} 03:31:43 INFO - https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:44 INFO - Downloaded 23813397 bytes. 03:31:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:45 INFO - Return code: 0 03:31:45 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')]} 03:31:45 INFO - https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:46 INFO - Downloaded 10840145 bytes. 03:31:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:31:46 INFO - Return code: 0 03:31:46 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')]} 03:31:46 INFO - https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:48 INFO - Downloaded 62689629 bytes. 03:31:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:48 INFO - mkdir: /builds/slave/test/properties 03:31:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:48 INFO - Contents: 03:31:48 INFO - build_url:https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:49 INFO - Running post-action listener: _resource_record_post_action 03:31:49 INFO - Running post-action listener: set_extra_try_arguments 03:31:49 INFO - ##### 03:31:49 INFO - ##### Running populate-webroot step. 03:31:49 INFO - ##### 03:31:49 INFO - Running pre-action listener: _resource_record_pre_action 03:31:49 INFO - Running main action method: populate_webroot 03:31:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:49 INFO - '--tppagecycles', 03:31:49 INFO - '7'], 03:31:49 INFO - 'tests': ['tsvgm']}}, 03:31:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['damp', 'tps']}, 03:31:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'tests': ['damp', 'tps']}, 03:31:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['dromaeo_dom']}, 03:31:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['a11yr', 03:31:49 INFO - 'ts_paint', 03:31:49 INFO - 'tpaint', 03:31:49 INFO - 'sessionrestore', 03:31:49 INFO - 'sessionrestore_no_auto_restore', 03:31:49 INFO - 'tabpaint']}, 03:31:49 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:49 INFO - 'ts_paint', 03:31:49 INFO - 'tpaint', 03:31:49 INFO - 'sessionrestore', 03:31:49 INFO - 'sessionrestore_no_auto_restore', 03:31:49 INFO - 'tabpaint']}, 03:31:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:49 INFO - 'ts_paint', 03:31:49 INFO - 'tpaint', 03:31:49 INFO - 'sessionrestore', 03:31:49 INFO - 'sessionrestore_no_auto_restore', 03:31:49 INFO - 'tabpaint']}, 03:31:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:49 INFO - 'ts_paint', 03:31:49 INFO - 'tpaint', 03:31:49 INFO - 'sessionrestore', 03:31:49 INFO - 'sessionrestore_no_auto_restore', 03:31:49 INFO - 'tabpaint']}, 03:31:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['a11yr', 03:31:49 INFO - 'ts_paint', 03:31:49 INFO - 'tpaint', 03:31:49 INFO - 'sessionrestore', 03:31:49 INFO - 'sessionrestore_no_auto_restore', 03:31:49 INFO - 'tabpaint']}, 03:31:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['a11yr', 03:31:49 INFO - 'ts_paint', 03:31:49 INFO - 'tpaint', 03:31:49 INFO - 'sessionrestore', 03:31:49 INFO - 'sessionrestore_no_auto_restore', 03:31:49 INFO - 'tabpaint']}, 03:31:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['tsvgx', 03:31:49 INFO - 'tsvgr_opacity', 03:31:49 INFO - 'tart', 03:31:49 INFO - 'tscrollx', 03:31:49 INFO - 'cart']}, 03:31:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:49 INFO - 'tsvgr_opacity', 03:31:49 INFO - 'tart', 03:31:49 INFO - 'tscrollx', 03:31:49 INFO - 'cart']}, 03:31:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'talos_options': ['--disable-e10s'], 03:31:49 INFO - 'tests': ['tp5o']}, 03:31:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'tests': ['tp5o']}, 03:31:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'talos_options': ['--disable-e10s', 03:31:49 INFO - '--xperf_path', 03:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:49 INFO - 'tests': ['tp5n']}, 03:31:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:49 INFO - 'talos_options': ['--xperf_path', 03:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:49 INFO - 'tests': ['tp5n']}}, 03:31:49 INFO - 'talos.zip': {'path': '', 03:31:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:49 INFO - Running post-action listener: _resource_record_post_action 03:31:49 INFO - ##### 03:31:49 INFO - ##### Running create-virtualenv step. 03:31:49 INFO - ##### 03:31:49 INFO - Running pre-action listener: _resource_record_pre_action 03:31:49 INFO - Running main action method: create_virtualenv 03:31:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:49 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 03:31:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:49 INFO - Using real prefix '/usr' 03:31:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:51 INFO - Installing pip.................done. 03:31:51 INFO - Return code: 0 03:31:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:51 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')]} 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 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')]} 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:31:51 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 03:31:51 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 03:31:51 INFO - Using env: {'DISPLAY': ':0', 03:31:51 INFO - 'HOME': '/home/cltbld', 03:31:51 INFO - 'LANG': 'en_US.UTF-8', 03:31:51 INFO - 'LANGUAGE': 'en_US:en', 03:31:51 INFO - 'LOGNAME': 'cltbld', 03:31:51 INFO - 'MAIL': '/var/mail/cltbld', 03:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:51 INFO - 'MOZ_NO_REMOTE': '1', 03:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:51 INFO - 'NO_EM_RESTART': '1', 03:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:51 INFO - 'PWD': '/builds/slave/test', 03:31:51 INFO - 'SHELL': '/bin/bash', 03:31:51 INFO - 'SHLVL': '1', 03:31:51 INFO - 'TERM': 'linux', 03:31:51 INFO - 'TMOUT': '86400', 03:31:51 INFO - 'USER': 'cltbld', 03:31:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:51 INFO - '_': '/tools/buildbot/bin/python'} 03:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:52 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 03:31:52 INFO - Cleaning up... 03:31:52 INFO - Return code: 0 03:31:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:52 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:31:52 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 03:31:52 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 03:31:52 INFO - Using env: {'DISPLAY': ':0', 03:31:52 INFO - 'HOME': '/home/cltbld', 03:31:52 INFO - 'LANG': 'en_US.UTF-8', 03:31:52 INFO - 'LANGUAGE': 'en_US:en', 03:31:52 INFO - 'LOGNAME': 'cltbld', 03:31:52 INFO - 'MAIL': '/var/mail/cltbld', 03:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:52 INFO - 'MOZ_NO_REMOTE': '1', 03:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:52 INFO - 'NO_EM_RESTART': '1', 03:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:52 INFO - 'PWD': '/builds/slave/test', 03:31:52 INFO - 'SHELL': '/bin/bash', 03:31:52 INFO - 'SHLVL': '1', 03:31:52 INFO - 'TERM': 'linux', 03:31:52 INFO - 'TMOUT': '86400', 03:31:52 INFO - 'USER': 'cltbld', 03:31:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:52 INFO - '_': '/tools/buildbot/bin/python'} 03:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:52 INFO - Downloading/unpacking psutil>=0.7.1 03:31:52 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 03:31:52 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 03:31:52 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 03:31:52 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 03:31:52 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 03:31:52 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 03:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:54 INFO - Installing collected packages: psutil 03:31:54 INFO - Running setup.py install for psutil 03:31:54 INFO - building 'psutil._psutil_linux' extension 03:31:54 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 03:31:54 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 03:31:54 INFO - building 'psutil._psutil_posix' extension 03:31:54 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 03:31:54 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 03:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:54 INFO - Successfully installed psutil 03:31:54 INFO - Cleaning up... 03:31:54 INFO - Return code: 0 03:31:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:31:54 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')]} 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:54 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')]} 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:54 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:31:54 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 03:31:54 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 03:31:54 INFO - Using env: {'DISPLAY': ':0', 03:31:54 INFO - 'HOME': '/home/cltbld', 03:31:54 INFO - 'LANG': 'en_US.UTF-8', 03:31:54 INFO - 'LANGUAGE': 'en_US:en', 03:31:54 INFO - 'LOGNAME': 'cltbld', 03:31:54 INFO - 'MAIL': '/var/mail/cltbld', 03:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:54 INFO - 'MOZ_NO_REMOTE': '1', 03:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:54 INFO - 'NO_EM_RESTART': '1', 03:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:54 INFO - 'PWD': '/builds/slave/test', 03:31:54 INFO - 'SHELL': '/bin/bash', 03:31:54 INFO - 'SHLVL': '1', 03:31:54 INFO - 'TERM': 'linux', 03:31:54 INFO - 'TMOUT': '86400', 03:31:54 INFO - 'USER': 'cltbld', 03:31:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:54 INFO - '_': '/tools/buildbot/bin/python'} 03:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:31:56 INFO - Installing collected packages: mozsystemmonitor 03:31:56 INFO - Running setup.py install for mozsystemmonitor 03:31:57 INFO - Successfully installed mozsystemmonitor 03:31:57 INFO - Cleaning up... 03:31:57 INFO - Return code: 0 03:31:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:57 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:31:57 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 03:31:57 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 03:31:57 INFO - Using env: {'DISPLAY': ':0', 03:31:57 INFO - 'HOME': '/home/cltbld', 03:31:57 INFO - 'LANG': 'en_US.UTF-8', 03:31:57 INFO - 'LANGUAGE': 'en_US:en', 03:31:57 INFO - 'LOGNAME': 'cltbld', 03:31:57 INFO - 'MAIL': '/var/mail/cltbld', 03:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:57 INFO - 'MOZ_NO_REMOTE': '1', 03:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:57 INFO - 'NO_EM_RESTART': '1', 03:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:57 INFO - 'PWD': '/builds/slave/test', 03:31:57 INFO - 'SHELL': '/bin/bash', 03:31:57 INFO - 'SHLVL': '1', 03:31:57 INFO - 'TERM': 'linux', 03:31:57 INFO - 'TMOUT': '86400', 03:31:57 INFO - 'USER': 'cltbld', 03:31:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:57 INFO - '_': '/tools/buildbot/bin/python'} 03:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 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 03:31:59 INFO - Downloading docopt-0.6.1.tar.gz 03:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:59 INFO - Running setup.py install for blobuploader 03:32:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:00 INFO - Running setup.py install for requests 03:32:00 INFO - Running setup.py install for docopt 03:32:00 INFO - Successfully installed blobuploader requests docopt 03:32:00 INFO - Cleaning up... 03:32:00 INFO - Return code: 0 03:32:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:00 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')]} 03:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:00 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')]} 03:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:00 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:32:00 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 03:32:00 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 03:32:00 INFO - Using env: {'DISPLAY': ':0', 03:32:00 INFO - 'HOME': '/home/cltbld', 03:32:00 INFO - 'LANG': 'en_US.UTF-8', 03:32:00 INFO - 'LANGUAGE': 'en_US:en', 03:32:00 INFO - 'LOGNAME': 'cltbld', 03:32:00 INFO - 'MAIL': '/var/mail/cltbld', 03:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:00 INFO - 'MOZ_NO_REMOTE': '1', 03:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:00 INFO - 'NO_EM_RESTART': '1', 03:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:00 INFO - 'PWD': '/builds/slave/test', 03:32:00 INFO - 'SHELL': '/bin/bash', 03:32:00 INFO - 'SHLVL': '1', 03:32:00 INFO - 'TERM': 'linux', 03:32:00 INFO - 'TMOUT': '86400', 03:32:00 INFO - 'USER': 'cltbld', 03:32:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:00 INFO - '_': '/tools/buildbot/bin/python'} 03:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:00 INFO - Running setup.py (path:/tmp/pip-yxxPkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:00 INFO - Running setup.py (path:/tmp/pip-gqLITw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:00 INFO - Running setup.py (path:/tmp/pip-caYi9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:01 INFO - Running setup.py (path:/tmp/pip-QL7NIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:01 INFO - Running setup.py (path:/tmp/pip-e6n5mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:01 INFO - Running setup.py (path:/tmp/pip-iCCKFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:01 INFO - Running setup.py (path:/tmp/pip-MxJSjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:01 INFO - Running setup.py (path:/tmp/pip-lIVYTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:01 INFO - Running setup.py (path:/tmp/pip-WoIK5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:01 INFO - Running setup.py (path:/tmp/pip-pkL_4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:01 INFO - Running setup.py (path:/tmp/pip-Z0vL38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:01 INFO - Running setup.py (path:/tmp/pip-cs_Ax4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:01 INFO - Running setup.py (path:/tmp/pip-1tt4l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:01 INFO - Running setup.py (path:/tmp/pip-515A41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:01 INFO - Running setup.py (path:/tmp/pip-0HwT5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:01 INFO - Running setup.py (path:/tmp/pip-BTul41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:01 INFO - Running setup.py (path:/tmp/pip-Qfuo2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:02 INFO - Running setup.py install for manifestparser 03:32:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Running setup.py install for mozcrash 03:32:02 INFO - Running setup.py install for mozdebug 03:32:02 INFO - Running setup.py install for mozdevice 03:32:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Running setup.py install for mozfile 03:32:02 INFO - Running setup.py install for mozhttpd 03:32:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Running setup.py install for mozinfo 03:32:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Running setup.py install for mozInstall 03:32:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:02 INFO - Running setup.py install for mozleak 03:32:02 INFO - Running setup.py install for mozlog 03:32:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for moznetwork 03:32:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozprocess 03:32:03 INFO - Running setup.py install for mozprofile 03:32:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozrunner 03:32:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozscreenshot 03:32:03 INFO - Running setup.py install for moztest 03:32:03 INFO - Running setup.py install for mozversion 03:32:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:03 INFO - Cleaning up... 03:32:03 INFO - Return code: 0 03:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:32:03 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 03:32:03 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 03:32:03 INFO - Using env: {'DISPLAY': ':0', 03:32:03 INFO - 'HOME': '/home/cltbld', 03:32:03 INFO - 'LANG': 'en_US.UTF-8', 03:32:03 INFO - 'LANGUAGE': 'en_US:en', 03:32:03 INFO - 'LOGNAME': 'cltbld', 03:32:03 INFO - 'MAIL': '/var/mail/cltbld', 03:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:03 INFO - 'MOZ_NO_REMOTE': '1', 03:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:03 INFO - 'NO_EM_RESTART': '1', 03:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:03 INFO - 'PWD': '/builds/slave/test', 03:32:03 INFO - 'SHELL': '/bin/bash', 03:32:03 INFO - 'SHLVL': '1', 03:32:03 INFO - 'TERM': 'linux', 03:32:03 INFO - 'TMOUT': '86400', 03:32:03 INFO - 'USER': 'cltbld', 03:32:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:03 INFO - '_': '/tools/buildbot/bin/python'} 03:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:04 INFO - Running setup.py (path:/tmp/pip-TQKE2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:04 INFO - Running setup.py (path:/tmp/pip-8xBgNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:04 INFO - Running setup.py (path:/tmp/pip-ZmPoaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:04 INFO - Running setup.py (path:/tmp/pip-dHlKCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:04 INFO - Running setup.py (path:/tmp/pip-mubSUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:04 INFO - Running setup.py (path:/tmp/pip-fEZUkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:04 INFO - Running setup.py (path:/tmp/pip-Imdq4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:04 INFO - Running setup.py (path:/tmp/pip-6OvRvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:04 INFO - Running setup.py (path:/tmp/pip-M9wlAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:04 INFO - Running setup.py (path:/tmp/pip-jtcxbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:04 INFO - Running setup.py (path:/tmp/pip-R6hbpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:04 INFO - Running setup.py (path:/tmp/pip-a4FZwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:04 INFO - Running setup.py (path:/tmp/pip-C93CxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:04 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)) 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:04 INFO - Running setup.py (path:/tmp/pip-YoaXW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:05 INFO - Running setup.py (path:/tmp/pip-oJrOSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:05 INFO - Running setup.py (path:/tmp/pip-Hax3Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:05 INFO - Running setup.py (path:/tmp/pip-8v04Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:05 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)) 03:32:05 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)) 03:32:05 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)) 03:32:05 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)) 03:32:05 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)) 03:32:05 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)) 03:32:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:07 INFO - Downloading blessings-1.6.tar.gz 03:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:07 INFO - Installing collected packages: blessings 03:32:07 INFO - Running setup.py install for blessings 03:32:07 INFO - Successfully installed blessings 03:32:07 INFO - Cleaning up... 03:32:07 INFO - Return code: 0 03:32:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:07 INFO - Reading from file tmpfile_stdout 03:32:07 INFO - Current package versions: 03:32:07 INFO - argparse == 1.2.1 03:32:07 INFO - blessings == 1.6 03:32:07 INFO - blobuploader == 1.2.4 03:32:07 INFO - docopt == 0.6.1 03:32:07 INFO - manifestparser == 1.1 03:32:07 INFO - mozInstall == 1.12 03:32:07 INFO - mozcrash == 0.17 03:32:07 INFO - mozdebug == 0.1 03:32:07 INFO - mozdevice == 0.48 03:32:07 INFO - mozfile == 1.2 03:32:07 INFO - mozhttpd == 0.7 03:32:07 INFO - mozinfo == 0.9 03:32:07 INFO - mozleak == 0.1 03:32:07 INFO - mozlog == 3.1 03:32:07 INFO - moznetwork == 0.27 03:32:07 INFO - mozprocess == 0.22 03:32:07 INFO - mozprofile == 0.28 03:32:07 INFO - mozrunner == 6.11 03:32:07 INFO - mozscreenshot == 0.1 03:32:07 INFO - mozsystemmonitor == 0.0 03:32:07 INFO - moztest == 0.7 03:32:07 INFO - mozversion == 1.4 03:32:07 INFO - psutil == 3.1.1 03:32:07 INFO - requests == 1.2.3 03:32:07 INFO - wsgiref == 0.1.2 03:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:07 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:32:07 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 03:32:07 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 03:32:07 INFO - Using env: {'DISPLAY': ':0', 03:32:07 INFO - 'HOME': '/home/cltbld', 03:32:07 INFO - 'LANG': 'en_US.UTF-8', 03:32:07 INFO - 'LANGUAGE': 'en_US:en', 03:32:07 INFO - 'LOGNAME': 'cltbld', 03:32:07 INFO - 'MAIL': '/var/mail/cltbld', 03:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:07 INFO - 'MOZ_NO_REMOTE': '1', 03:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:07 INFO - 'NO_EM_RESTART': '1', 03:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:07 INFO - 'PWD': '/builds/slave/test', 03:32:07 INFO - 'SHELL': '/bin/bash', 03:32:07 INFO - 'SHLVL': '1', 03:32:07 INFO - 'TERM': 'linux', 03:32:07 INFO - 'TMOUT': '86400', 03:32:07 INFO - 'USER': 'cltbld', 03:32:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:07 INFO - '_': '/tools/buildbot/bin/python'} 03:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 INFO - Cleaning up... 03:32:07 INFO - Return code: 0 03:32:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:32: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', 'jsonschema'] in /builds/slave/test/build 03:32: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 jsonschema 03:32:07 INFO - Using env: {'DISPLAY': ':0', 03:32:07 INFO - 'HOME': '/home/cltbld', 03:32:07 INFO - 'LANG': 'en_US.UTF-8', 03:32:07 INFO - 'LANGUAGE': 'en_US:en', 03:32:07 INFO - 'LOGNAME': 'cltbld', 03:32:07 INFO - 'MAIL': '/var/mail/cltbld', 03:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:07 INFO - 'MOZ_NO_REMOTE': '1', 03:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:07 INFO - 'NO_EM_RESTART': '1', 03:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:07 INFO - 'PWD': '/builds/slave/test', 03:32:07 INFO - 'SHELL': '/bin/bash', 03:32:07 INFO - 'SHLVL': '1', 03:32:07 INFO - 'TERM': 'linux', 03:32:07 INFO - 'TMOUT': '86400', 03:32:07 INFO - 'USER': 'cltbld', 03:32:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:07 INFO - '_': '/tools/buildbot/bin/python'} 03:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:08 INFO - Downloading/unpacking jsonschema 03:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:10 INFO - Downloading/unpacking functools32 (from jsonschema) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:10 INFO - warning: no files found matching '*.txt' 03:32:10 INFO - no previously-included directories found matching 'build' 03:32:10 INFO - no previously-included directories found matching 'dist' 03:32:10 INFO - no previously-included directories found matching '.git*' 03:32:10 INFO - Installing collected packages: jsonschema, functools32 03:32:10 INFO - Running setup.py install for functools32 03:32:10 INFO - warning: no files found matching '*.txt' 03:32:10 INFO - no previously-included directories found matching 'build' 03:32:10 INFO - no previously-included directories found matching 'dist' 03:32:10 INFO - no previously-included directories found matching '.git*' 03:32:10 INFO - Successfully installed jsonschema functools32 03:32:10 INFO - Cleaning up... 03:32:10 INFO - Return code: 0 03:32:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:32:10 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')]} 03:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 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')]} 03:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 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 0x7f598de2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', '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 03:32:10 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 03:32:10 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 03:32:10 INFO - Using env: {'DISPLAY': ':0', 03:32:10 INFO - 'HOME': '/home/cltbld', 03:32:10 INFO - 'LANG': 'en_US.UTF-8', 03:32:10 INFO - 'LANGUAGE': 'en_US:en', 03:32:10 INFO - 'LOGNAME': 'cltbld', 03:32:10 INFO - 'MAIL': '/var/mail/cltbld', 03:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:10 INFO - 'MOZ_NO_REMOTE': '1', 03:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:10 INFO - 'NO_EM_RESTART': '1', 03:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:10 INFO - 'PWD': '/builds/slave/test', 03:32:10 INFO - 'SHELL': '/bin/bash', 03:32:10 INFO - 'SHLVL': '1', 03:32:10 INFO - 'TERM': 'linux', 03:32:10 INFO - 'TMOUT': '86400', 03:32:10 INFO - 'USER': 'cltbld', 03:32:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:10 INFO - '_': '/tools/buildbot/bin/python'} 03:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:10 INFO - Downloading/unpacking flake8 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:13 INFO - no previously-included directories found matching 'docs/_build' 03:32:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:13 INFO - Running setup.py install for pep8 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:13 INFO - no previously-included directories found matching 'docs/_build' 03:32:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:13 INFO - Cleaning up... 03:32:13 INFO - Return code: 0 03:32:13 INFO - Running post-action listener: _resource_record_post_action 03:32:13 INFO - Running post-action listener: _start_resource_monitoring 03:32:13 INFO - Starting resource monitoring. 03:32:13 INFO - ##### 03:32:13 INFO - ##### Running install step. 03:32:13 INFO - ##### 03:32:13 INFO - Running pre-action listener: _resource_record_pre_action 03:32:13 INFO - Running main action method: install 03:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:13 INFO - Reading from file tmpfile_stdout 03:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:13 INFO - Reading from file tmpfile_stdout 03:32:13 INFO - Output received: 03:32:13 INFO - Usage: mozinstall [options] installer 03:32:13 INFO - Options: 03:32:13 INFO - -h, --help show this help message and exit 03:32:13 INFO - -d DEST, --destination=DEST 03:32:13 INFO - Directory to install application into. [default: 03:32:13 INFO - "/builds/slave/test"] 03:32:13 INFO - --app=APP Application being installed. [default: firefox] 03:32:13 INFO - mkdir: /builds/slave/test/build/application 03:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:32:29 INFO - Reading from file tmpfile_stdout 03:32:29 INFO - Output received: 03:32:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:29 INFO - Running post-action listener: _resource_record_post_action 03:32:29 INFO - ##### 03:32:29 INFO - ##### Running run-tests step. 03:32:29 INFO - ##### 03:32:29 INFO - Running pre-action listener: _resource_record_pre_action 03:32:29 INFO - Running main action method: run_tests 03:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:29 INFO - Python 2.7.3 03:32:29 INFO - Return code: 0 03:32:29 INFO - grabbing minidump binary from tooltool 03:32:29 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')]} 03:32:29 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 0x26fa410>, '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 0x26fb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:29 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 03:32:29 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 03:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:29 INFO - Return code: 0 03:32:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:30 INFO - Return code: 0 03:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 03:32:30 INFO - Using env: {'DISPLAY': ':0', 03:32:30 INFO - 'HOME': '/home/cltbld', 03:32:30 INFO - 'LANG': 'en_US.UTF-8', 03:32:30 INFO - 'LANGUAGE': 'en_US:en', 03:32:30 INFO - 'LOGNAME': 'cltbld', 03:32:30 INFO - 'MAIL': '/var/mail/cltbld', 03:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:30 INFO - 'MOZ_NO_REMOTE': '1', 03:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:30 INFO - 'NO_EM_RESTART': '1', 03:32:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:30 INFO - 'PWD': '/builds/slave/test', 03:32:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:30 INFO - 'SHELL': '/bin/bash', 03:32:30 INFO - 'SHLVL': '1', 03:32:30 INFO - 'TERM': 'linux', 03:32:30 INFO - 'TMOUT': '86400', 03:32:30 INFO - 'USER': 'cltbld', 03:32:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153', 03:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:30 INFO - '_': '/tools/buildbot/bin/python'} 03:32:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:32:30 INFO - mozversion application_buildid: 20160520004020 03:32:30 INFO - mozversion application_changeset: 9ba18aae69e626a3f83560df321d91e42316083a 03:32:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:30 INFO - mozversion application_name: Firefox 03:32:30 INFO - mozversion application_remotingname: firefox-dev 03:32:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:30 INFO - mozversion application_vendor: Mozilla 03:32:30 INFO - mozversion application_version: 48.0a2 03:32:30 INFO - mozversion platform_buildid: 20160520004020 03:32:30 INFO - mozversion platform_changeset: 9ba18aae69e626a3f83560df321d91e42316083a 03:32:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:30 INFO - mozversion platform_version: 48.0a2 03:32:30 INFO - using testdate: 1463740350 03:32:30 INFO - actual date: 1463740350 03:32:30 INFO - starting webserver on 'localhost:50484' 03:32:30 INFO - SUITE-START | Running 2 tests 03:32:30 INFO - TEST-START | dromaeo_css 03:32:30 INFO - operating with platform_type : linux_ 03:32:30 INFO - Initialising browser for dromaeo_css test... 03:32:30 INFO - TEST-INFO | started process 31197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeZGC_x/profile http://localhost:50484/getInfo.html) 03:32:34 INFO - PROCESS | 31197 | __metrics Screen width/height:1600/1200 03:32:34 INFO - PROCESS | 31197 | colorDepth:24 03:32:34 INFO - PROCESS | 31197 | Browser inner width/height: 1024/697 03:32:34 INFO - PROCESS | 31197 | __metrics 03:32:35 ERROR - PROCESS | 31197 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:32:36 INFO - TEST-INFO | 31197: exit 0 03:32:36 INFO - Browser initialized. 03:32:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:36 INFO - TEST-INFO | started process 31289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeZGC_x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:48 INFO - PROCESS | 31289 | RSS: Main: 141893632 03:32:48 INFO - PROCESS | 31289 | 03:33:39 INFO - PROCESS | 31289 | 1463740419152 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] 03:35:46 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50484/tests/dromaeo/cssquery-ext.html) 03:35:47 INFO - PROCESS | 31289 | RSS: Main: 245424128 03:35:47 INFO - PROCESS | 31289 | 03:38:49 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-ext.html (next: http://localhost:50484/tests/dromaeo/cssquery-jquery.html) 03:38:50 INFO - PROCESS | 31289 | RSS: Main: 218959872 03:38:50 INFO - PROCESS | 31289 | 03:41:52 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50484/tests/dromaeo/cssquery-mootools.html) 03:41:52 INFO - PROCESS | 31289 | RSS: Main: 215121920 03:41:52 INFO - PROCESS | 31289 | 03:44:54 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50484/tests/dromaeo/cssquery-prototype.html) 03:44:55 INFO - PROCESS | 31289 | RSS: Main: 214315008 03:44:55 INFO - PROCESS | 31289 | 03:47:57 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50484/tests/dromaeo/cssquery-yui.html) 03:47:58 INFO - PROCESS | 31289 | RSS: Main: 212041728 03:47:58 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-yui.html (next: http://localhost:50484/tests/dromaeo/cssquery-dojo.html) 03:51:00 INFO - PROCESS | 31289 | RSS: Main: 244658176 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | __start_tp_report 03:51:00 INFO - PROCESS | 31289 | _x_x_mozilla_page_load 03:51:00 INFO - PROCESS | 31289 | _x_x_mozilla_page_load_details 03:51:00 INFO - PROCESS | 31289 | |i|pagename|runs| 03:51:00 INFO - PROCESS | 31289 | |0;dojo.html;3293.7859039162454;3361.4789707595332;3366.1584603849046;3381.594208694957;3392.5420068290787;5473.124300111978;5508.614396992212;5513.228148059265;5513.979913715965;5519.144532597449;5523.7790488380415;5547.223388725572;5553.72231388431;5563.443655634434;5583.190437386576;4870.050340183666;4998.950010499894;5041.8235361762345;5128.282040514331;5156.04613146569;4836.105320515699;4899.510048995107;4902.558769710726;4902.583280421169;4912.38595175603;4912.828051018215;5035.144025515671;5091.083604951107;5121.564667003309;5125.231215317714;5041.344625198719;5066.214736715778;5080.974595127038;5087.287779710843;5116.539511443988;4910.533499317559;4943.1596628573225;4997.85006449807;5004.224345226496;5010.69935803853;5440.564754819605;5463.508284254436;5471.808486702986;5489.204065410533;5492.505674489315;5783.624064435799;5791.913121303184;5821.767129314822;5846.918320110751;5847.795327163529;5806.042003069489;5841.649501029951;5887.7635696503785;5906.084556893688;5943.4056594340655;5441.102218134043;5476.4249753775675;5484.698341591211;5487.204355368449;5492.917606235909;5762.538996880239;5964.045752679637;5968.970155149196;5969.283685957713;5986.850328741816;5709.68596727184;5726.627769195073;5729.799457019068;5731.283589551306;5753.309602847601;5849.473547380756;5850.297964244232;5852.531797456193;5853.824385268449;5858.091995740667;5639.154126880919;5821.708914554255;5824.388439213906;5826.067829147316;5867.295924489089;5822.592418530747;5850.853728656818;5854.736536855852;5885.382034886361;5901.17383566301;4490.146872094291;4509.503954564995;4509.909801803946;4511.323301504735;4534.750588717652;3956.188981258835;3993.4209539616595;4026.315526360526;4067.247559201557;4076.021754778891;5535.861603459945;5565.026120428909;5569.721513924369;5575.219469274305;5590.86022849432;5902.675352855548;5921.259842519685;5923.348431672513;5927.970360148258;5933.732982015733;5412.83761487156;5558.305211848519;5609.775608975677;5645.294338207724;5717.542596592262;5105.923411148836;5107.438181799999;5123.769430375642;5130.256112863613;5137.049645815536;6131.294901086432;6137.754489820447;6139.10982907476;6139.447449729546;6140.385961403913;5723.942760572508;5841.4450627190345;5919.704014799329;5922.437368449991;5950.732217050329;6099.512039036777;6143.648397352576;6145.66198859067;6147.938520614915;6148.385161483816;5799.739011744397;5804.361520232686;5812.912806307993;5813;5825.3592104867585;5793.913091303718;5914.142449344907;5926.733297001559;6007.068904319837;6012.909806352821;5791.681457519877;5809.331926828469;5814.5348372130975;5815.41845815415;5815.9709201453725;5732.656040637575;5770.942290577041;5779.104238842986;5786.161006654096;5789.2763404574425;5533.474319939599;5740.51205647508;5811.79658711943;5813.534917206698;5827.155062515996;5795.652260864362;5826.82519524415;5828.358880523224;5831.94168058331;5834.708264586839;5454.672719636835;5636.661800291996;5698.088305871041;5704.942950570441;5721.456461636304 03:51:00 INFO - PROCESS | 31289 | |1;ext.html;668.1714673804483;672.7510820996231;682.123471339329;685.3523420367749;738.0294912190473;33882.491762623584;34528.82735586321;34539.30921381571;40754.38868416969;41393.17213655725;44139;44764;44785.55214447855;44794.77602611991;44845;8810.647574097044;8974.28205743539;8987.685431009915;8989.280857531381;8995.100489950984;8845.115488451136;8952.910470895273;8976.685815996441;8977.685780997634;8980.775480612972;8954.37319387643;9021.36850420471;9173.44959302444;9200.677976270832;9200.907990920072;9098.363114581982;9114.498702571356;9143.817123657556;9151.405158664666;9154.084591540826;9067;9185.49479778612;9203.493807840567;9204.125608067223;9209.263258939269;44157.55842441566;44190.558094418964;44327.335089973676;44336.77831610854;44671;3793.1655035892336;3868.3810590305698;4000.699947503949;4424.137293227822;4655.045715628288;31064;31155.53266701001;31230.53154202689;31264.843675781703;32341.83829080863;4635.930461043087;4660.300954856764;4687.484376718558;4704.506026867164;4707.176244157259;226171;231077;231282;231353.9999999983;231401;40122.1975560493;58930.41069589335;64274.500784944605;64276;64295.35704642894;39130.608693913266;39192;39256.60743392586;39397.212055758726;39468;16754.1622918856;17033.574160646083;17060.91469542669;17076.402325918534;17078.658426831393;13829.10110842792;13830.37763300654;13900.16599004063;13933.651658708613;13950.23273719955;9381.29640276982;9395.671151509665;9518.666846660471;9528.333016688764;9546.140847323773;3533.222691007974;3600.3339382214376;3618.87333943316;3638.0541059324764;3642.745007849478;1070.3310430980637;1145.8109411947103;1170.7365842685329;1176.2589568571746;1210.3040751567883;34801.65198347984;35269.17679376563;35465.46801797975;35498.29003419917;35704.82147589245;1234.5370486067725;1234.8947691815954;1235.2650173146963;1235.950561977511;1240.34881687115;17834.19746111428;18400.447986560426;18459.446216613524;18513.629727405376;18567.53581160482;466848;473081;473243;473668;473867;61176.38823611796;61676;61861.38138618646;62177.067343989875;62342.688286558274;1438.4318194313187;1453.3532578002687;1478.608168835238;1504.9623759405883;1514.8788096952217;33745;34247.486287706204;34367.48448773321;34619.48070778991;34706.65293347135;55838.162427562806;55906;56274;56374.718126409105;56387.43612563822;426446;428569;430537;430543;431205;28319.858400707864;30844.22889427782;31234.375312493168;31492.527612085378;32188.356232875678;45764.54235457603;46645.53354466412;46886.53113468958;46996.53003470058;47352.7632361836;37966.62033379631;38086;38102.428463573626;38254;39070.218595628496;36801.447978280885;39008;39533.40699889446;40990.385144222266;41506.58493415027;41813.372799408644;42351.1529769409;42795;42966.78516607397;43498.782506087264;36111.819440902626;36993.63006369902;37014;37395.6260437403;37702;28717.856410717814;28793.280167995967;29108.27229319284;29167.708322917348;29375.70624293815 03:51:00 INFO - PROCESS | 31289 | |2;jquery.html;429.5747210261841;437.39639297769077;438.13468399910164;439.0246319576238;451.68607817566783;18768.62462750744;19182.616347673054;19285.903570482147;20340.796592034076;20855.582888342262;19894.801051989474;20524.897375513137;20652.380428587167;20674;20674.06966686499;5679.346875109374;5753.338366087912;5909.586328956974;5914.319853216871;5929.229200203968;4296.957030429702;5794.362620111805;5880.147378630096;6094.908576371358;6409.839754006164;6383.425491705745;6399.136116624242;6408.551401401904;6409.102725618417;6412.839679008039;6146.877062458748;6352;6447.83880402989;6458.612483250997;6459.870802583922;4011.358182690785;4171.645410140141;5673.375928647845;5806.477417032487;5824.563157763185;14352.210628415432;14370.712585748332;14560.635984100376;14566.198859062748;21858.453538661503;2329.4758679297192;2359.988200059006;2492.0654754467073;2494.3390001649577;2573.7812285955715;10904.50929708165;11274.549018039268;12373.876261237363;13798.448062077505;15440.459583914622;2026.092260089565;2028.7471891747214;2074.3776866940007;2139.5827813576357;2163.8809865457392;78167.6091619544;78399.6080019602;80994;81033.59483202605;84365;10693.251472397013;11177.105831533621;11245;11323.32060076398;11476.827847582126;15845.920770396306;15966.281517331749;16043.759343609856;16069.758953615705;16087;8592.52741099233;8618.569071546523;8832.823343533093;8866.379353445196;8879.556022198993;8674.08922063187;8677.6528938843;8761.75814948473;8823.735287941372;8915.28677705782;5082.618803589746;5153;5154.871128221749;5159.045576568347;5198.766055527511;1899;1990.711346854727;2013.8791672499403;2031.7460317460318;2102.495401103755;989.4310771306527;1007.7077647482295;1094.950727217277;1110.8666959964694;1124.0726400719439;19104.713429298572;19182.904085479484;19433.12550935183;19433.222671092997;19489.830610163437;1074.2050882347007;1076.5263284154946;1102.3441052573705;1130.7625398666207;1131.4399372310759;10241.641542545975;10955.890441095646;10971.506282217319;10985.505652245509;11097.00126988575;536432;544171;549897;558991;565968;97261;98017;98976;104866.47566762117;110897.44551277193;1081.5133190064346;1093.94530273486;1112.694009147491;1118.4062710637309;1126.6845283320683;17273.222704978558;17320.13399330003;17491.825081749528;17711;17738.379156729454;40848.79575602103;41000.38499422571;41592.792036039624;41608.583914160474;41877.162456751306;59043.70478147582;61058;61983;62259;62485;8090.11008789021;8118.472299300763;8128.715494957648;8189.959050204711;8387.245147936716;12251.142420030512;12379.876201237872;12857.228566286052;12956.222626642431;13039.934800325938;11037.613683521038;11113.833292500458;11299.774004519699;11531.711707207387;11589.130815189063;10818.513166907665;10916.945415272872;11343.20597558163;11470.483828227916;11484.368359740294;10896;10909.618163364245;11287.43562821872;11423.257488263236;11462.14033947474;8052.476589021695;8082.2725954664365;8133.471324363897;8172.305354044973;8468.872966905377;9452;10410.115140213167;10765.515551800345;10938;11049.889501105208 03:51:00 INFO - PROCESS | 31289 | |3;mootools.html;1400.2088819816809;1474.7714104313832;1557.4393218441362;1722.9655406891864;1792.9282828686853;8120.878186827195;8430.409871308995;8444.071152173256;8445.78885527862;8463.57682115894;8360.205780450862;8538.957305213466;8539.146085391458;8542.487450752944;8543.57282135894;2123.3948324727457;2421.2615152378517;2444.8655323957173;2468.4816188600416;2482.404222986488;2446.1438496526252;2466.987665061672;2474.9752502474926;2478.10788116278;2482.2925466242123;2411.3850968003135;2439.7682220189054;2443.2670198940336;2444.083468699238;2445.070873068232;2106.6524023536176;2386.940326491843;2439.658447817307;2442.694663167113;2447.6695646087906;2313.745487996319;2341.824363172752;2354.587947109249;2356.163561935505;2368.538135063663;8496.447730897471;8564.957175214084;8565.743027709179;8573.52845593492;8582.485050896903;5382.67703937765;5493.862653433656;5537.667739935617;5544.306961629796;5559.972200139014;3523.894283171509;3530.4704294355797;3602.2975519773654;3604.098975256186;3644.4715516249994;1206.1255589697487;1214.574898785418;1234.3026190202597;1294.6828027133317;1298.6623477895814;12390.442430090667;12417.130800843945;12446.190997585129;12450.688732781753;12455.75088498225;4768.283417969528;4788.233882578771;4796.448408433005;4814.398200224972;4898.779554919965;10449.746030476239;10557.260991730658;10586.100181484506;10605.045545900752;10608.522616482276;4780.282957556325;5546.58400619947;5551.528120109755;5551.8889622207325;5554.444555544414;4904.950950490521;4974.502549744997;4986.526280003394;4998.600111991032;5045.369328833895;4115.279826030433;4157.210130075337;4168.291390463629;4213.2837417639075;4224.936625950613;1354.2889982758934;1364.7065880835669;1381.3369582600408;1387.1506569270355;1389;1051.9737006574896;1063.2769716592636;1064.2497039587072;1065.0521036277719;1083.8374243863325;6157.476614487729;6221.09794079865;6258.3428739982555;6321.462675672527;6371.776987805404;492.7582492119838;502.5602597726989;507.51785803486837;508.73545756207307;513.9640225184276;4087.305158123126;4097.959020409818;4148.91702165955;4156.896077598084;4180.435641188462;10466.162706983423;10815.621453249098;10949.069329106957;10974.615888444026;10988.230823842414;10726.570937162582;10757.515911783988;10757.731056723644;10783.406912619881;10799.244052916378;8270.048944371474;8329.458585191944;8438.36712246584;8441.493510389519;8442.62008209632;5948.078047902582;5990.850228744316;6022.5784195105925;6065.665553578206;6155.292141403616;9494.715158545254;9661.661841835503;9735.9026409735;9768.755781105529;9774.511274436392;9644.469554174588;9919.900800991898;10035.397876127456;10261.333013354108;10264.589416423558;7461.813454663677;7645.961770191114;7694.846103077795;7890.526568405914;7920.603969801602;8351.665933362598;8363.289120424832;8368.205020523284;8373.288270496832;8402.831943361221;7507.174210836913;7616.04799400075;7637.121731001006;7730.884036739341;7786.688532458638;7481.66332515049;7555.471117021756;7565.43259255547;7604.733834315994;7719.189485103983;7170.820729481805;7176.96411517939;7222.133343998754;7257.637118144177;7258.237885022208;5052.267421223828;5129.846104616868;5196.558292545176;5210.140326846028;5219.112750832443;5266.183741520071;5269.314989051399;5301.1783173608155;5314.760835762323;5364.034473794754 03:51:00 INFO - PROCESS | 31289 | |4;prototype.html;365.72753298792406;365.87011610878136;366.8495916674164;370.1578907984336;372.83595218104017;6090.634561926282;6177.567570270077;6205.689715514218;6223.284322302937;6238.469730072938;6150.938490615093;6183.010718285075;6185.134081228632;6187.65967871768;6191.721372538235;4532.546745325474;4660.813567457298;4751.40607424072;4756.714597124166;4763;4750.643701722367;4771.451283102436;4772.093302272575;4777.689450185744;4779.115863565252;4718.079974404993;4723.338732577442;4723.5512626300615;4734.55021772931;4736.810527578893;4490.57339552742;4595.747233902134;4688.156131896258;4732;4740.478547359788;4134.152498737752;4140.171965606861;4143.81352839123;4148.149629325981;4153.792310384469;5865.912011319833;5947.4052594740615;5953.047512398039;5967.045272756382;5976.760929562813;5508.063629183049;5515.586331025149;5521.254630624894;5521.917171242435;5543;6536.9673151634415;6546.9017964730565;6553.803385898431;6554;6556.114924485181;4561.589456948891;4637.397138372024;4641.698289611199;4651.674382793206;4657.347971284023;6760.0535924970545;6824.556403833735;6828.180618325832;6835.7949261522235;6840.144981877265;4761.52384761528;4765.8570242892765;4768.0702263059065;4773.618110551148;4777.928331075037;4826.541478559531;4828.251620998681;4832.710037397697;4835.468098509161;4841.491643377394;5514.779408823682;5523.585731070186;5523.861903452445;5532.585056120807;5535.142052981794;6323.177986861679;6523.217213934264;6556.114924485229;6556.475481961432;6567.605943643397;1630.4049022106847;1631.331154226785;1636.5925304238347;1642.852143307108;1643.0962970366252;1080.8324709669857;1093.1418836213534;1102.366139469808;1103.812351900179;1108.4180805077237;6183.505319574423;6302.779402720883;6304;6376.39424254695;6385.722855428933;6727.360900714424;6807.4894382921475;6820.31796820324;6821.386075253251;6825.215100263434;6455.515231496688;6463.7091330890225;6465.094886715863;6471.288158302583;6472.676366181766;3578.481120237551;3647.2705458908326;3648.4527320901548;3650.4341827016856;3651.1784848408897;6959.338862808025;7075.893861592081;7082.291770822876;7102.218755936843;7124;6864.622445765531;6895.724171033103;6899.793006209822;6908.9309106909295;6910.2744211858035;7068.187158476738;7090;7091.432685385157;7099.538529995637;7101.964490177619;6765.1205343305055;6768.830779230559;6785.050092986887;6786.423154031962;6792.558483698544;6606.306337834651;6703.061571380108;6704.899426508508;6771.52599318043;6774.424173945073;7109.893351599627;7147.8570428592175;7150;7152.928470715435;7156.964215178891;4560.931586026279;4586.656000799887;4587.334836448629;4588.311753237042;4591.494935557019;6795.72817087311;6796.490263230178;6800.217974932946;6801.591904485549;6801.931980680328;6461.741530338733;6640.169978752656;6645.933540664725;6647.302033286435;6669.7665581704405;6591.077249185214;6596;6613.603183808795;6629.3039230882;6663.633500157538;6499.1876015498065;6500.5449618526245;6503.837404064936;6518.967405162944;6523.934760652332;6633.170853643294;6639.502037347315;6650.235222949423;6652.76715314981;6661.666916654245;6383.968080159755;6480.25477070143;6484.935150648622;6491.707873145814;6517.348265173634 03:51:00 INFO - PROCESS | 31289 | |5;yui.html;833.2380445752523;847.7287268074215;854.8674955381916;855.3220312167824;858.9999999999998;14860.40558377665;15101.848981510182;15166.924165379172;15192.544223673307;15237.16195609241;13652.72694546111;13668.794968075463;13748.175109493437;13758.656033599165;13834.100783449068;732.8717474441978;866.0516734176067;880.903100658927;889.4663202078766;896.224765577777;886.7738726624734;887.2857349833381;891.3136884598855;891.4072142025577;891.7191084808264;933.8225737109927;934.0939288889766;934.3272843552631;935.6117211357279;935.9017303183169;781.2031727637806;788.8382881509277;789.4710543935548;908.2053203446984;929.3308817651314;686.989695154568;687.2303020616891;687.6114995027793;689;689.1351354050635;14273.643158921006;14408.351624176832;14433.566992990227;14445.927770361186;14452.277386130652;13630.795538066937;13684.247366394844;14045.508407205698;14257.857421425757;14545.054571452822;11219.831702524469;11333;11834.171607987444;12114;12271;4694.201985662411;4708.434987801452;4749.358836557055;4771.451283102453;4789.56893879549;54812.725936370465;55219.72390138024;55235.44764552343;55318;55414.16878746782;10376.429296388771;10656.946715266375;11554.711132221593;11756.35340056288;11960.342181179945;19246.4226073218;19295.228190872207;19419.029048547516;19497.902510487358;19517.707234391495;8599.656013759379;8618.138186181332;8623;8693.739187824376;8911.910880891108;4967.205247160437;4968.254761785761;4972.8508144755715;5082.440931497532;5133.204353325166;3667.7615954962844;3668.4680721295795;3673.3020726062496;3674.6876515496483;3678.3746763050344;677.8136012596477;686.9725210991504;687.1273482676972;694.3924066441863;714.2072299747276;650.6193876582253;660.0528241972785;688.215434404779;742.5581778841581;783.3772151139857;9346.813063738688;9654.806903861883;9715.174210192072;9961.750956226153;9964.601415943425;716.2443621978758;738.3945164964678;756.8486302739474;762.8016715653858;812.6911773526023;4491.438570178728;4535.614472769851;4573.085382923428;4575.771211439414;4614.700044497097;63008;63993;64081.679591602675;64237.67881160564;64296.03555946665;55973.72013139908;56542.151867722016;57054.71472642693;57192.71403642955;57605.71197143987;47902;48290.5170948286;48337;48443.51556484461;48634.513654862996;9667.468289243878;9785.657501987396;9815.85276220843;9878.357906736039;9961.35251208669;36334.8183259082;36350.8182459086;37388.813055934545;37759.244815104095;37938;42228.73313800591;46607;47420.52579474161;47974.760126199144;50423;11894;11923.701907452383;11928.463219155332;12053.216540924812;12324.876751232732;13037.608871733863;13042.608721738363;13086.345682716017;13350.465981361025;13643.181409115485;10873.401962892116;11124.888751112385;13267.40296686632;13790;13853.168809871037;13463.71116910108;13559.118657287245;13636.65908352299;13709.258148370565;13736.580516898608;13110.803337949748;13528;13813.654658633615;13898.305084745925;14278.643033924234;11087.279326843729;11128.777424451628;11201.327920324806;11342.262752921033;11448.94275528617;11190.384528850991;11426.485808138488;11670.416479176178;11680.357580333164;11758.294502329887 03:51:00 INFO - PROCESS | 31289 | __end_tp_report 03:51:00 INFO - PROCESS | 31289 | __start_cc_report 03:51:00 INFO - PROCESS | 31289 | _x_x_mozilla_cycle_collect,808 03:51:00 INFO - PROCESS | 31289 | __end_cc_report 03:51:00 INFO - PROCESS | 31289 | __startTimestamp1463741460784__endTimestamp 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | ------- Summary: start ------- 03:51:00 INFO - PROCESS | 31289 | Number of tests: 6 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | [#0] dojo.html Cycles:165 Average:5475.39 Median:5721.46 stddev:599.69 (10.5%) stddev-sans-first:576.59 03:51:00 INFO - PROCESS | 31289 | Values: 3293.8 3361.5 3366.2 3381.6 3392.5 5473.1 5508.6 5513.2 5514.0 5519.1 5523.8 5547.2 5553.7 5563.4 5583.2 4870.1 4999.0 5041.8 5128.3 5156.0 4836.1 4899.5 4902.6 4902.6 4912.4 4912.8 5035.1 5091.1 5121.6 5125.2 5041.3 5066.2 5081.0 5087.3 5116.5 4910.5 4943.2 4997.9 5004.2 5010.7 5440.6 5463.5 5471.8 5489.2 5492.5 5783.6 5791.9 5821.8 5846.9 5847.8 5806.0 5841.6 5887.8 5906.1 5943.4 5441.1 5476.4 5484.7 5487.2 5492.9 5762.5 5964.0 5969.0 5969.3 5986.9 5709.7 5726.6 5729.8 5731.3 5753.3 5849.5 5850.3 5852.5 5853.8 5858.1 5639.2 5821.7 5824.4 5826.1 5867.3 5822.6 5850.9 5854.7 5885.4 5901.2 4490.1 4509.5 4509.9 4511.3 4534.8 3956.2 3993.4 4026.3 4067.2 4076.0 5535.9 5565.0 5569.7 5575.2 5590.9 5902.7 5921.3 5923.3 5928.0 5933.7 5412.8 5558.3 5609.8 5645.3 5717.5 5105.9 5107.4 5123.8 5130.3 5137.0 6131.3 6137.8 6139.1 6139.4 6140.4 5723.9 5841.4 5919.7 5922.4 5950.7 6099.5 6143.6 6145.7 6147.9 6148.4 5799.7 5804.4 5812.9 5813.0 5825.4 5793.9 5914.1 5926.7 6007.1 6012.9 5791.7 5809.3 5814.5 5815.4 5816.0 5732.7 5770.9 5779.1 5786.2 5789.3 5533.5 5740.5 5811.8 5813.5 5827.2 5795.7 5826.8 5828.4 5831.9 5834.7 5454.7 5636.7 5698.1 5704.9 5721.5 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | [#1] ext.html Cycles:180 Average:54440.09 Median:40872.39 stddev:103844.19 (254.1%) stddev-sans-first:104057.02 03:51:00 INFO - PROCESS | 31289 | Values: 668.2 672.8 682.1 685.4 738.0 33882.5 34528.8 34539.3 40754.4 41393.2 44139.0 44764.0 44785.6 44794.8 44845.0 8810.6 8974.3 8987.7 8989.3 8995.1 8845.1 8952.9 8976.7 8977.7 8980.8 8954.4 9021.4 9173.4 9200.7 9200.9 9098.4 9114.5 9143.8 9151.4 9154.1 9067.0 9185.5 9203.5 9204.1 9209.3 44157.6 44190.6 44327.3 44336.8 44671.0 3793.2 3868.4 4000.7 4424.1 4655.0 31064.0 31155.5 31230.5 31264.8 32341.8 4635.9 4660.3 4687.5 4704.5 4707.2 226171.0 231077.0 231282.0 231354.0 231401.0 40122.2 58930.4 64274.5 64276.0 64295.4 39130.6 39192.0 39256.6 39397.2 39468.0 16754.2 17033.6 17060.9 17076.4 17078.7 13829.1 13830.4 13900.2 13933.7 13950.2 9381.3 9395.7 9518.7 9528.3 9546.1 3533.2 3600.3 3618.9 3638.1 3642.7 1070.3 1145.8 1170.7 1176.3 1210.3 34801.7 35269.2 35465.5 35498.3 35704.8 1234.5 1234.9 1235.3 1236.0 1240.3 17834.2 18400.4 18459.4 18513.6 18567.5 466848.0 473081.0 473243.0 473668.0 473867.0 61176.4 61676.0 61861.4 62177.1 62342.7 1438.4 1453.4 1478.6 1505.0 1514.9 33745.0 34247.5 34367.5 34619.5 34706.7 55838.2 55906.0 56274.0 56374.7 56387.4 426446.0 428569.0 430537.0 430543.0 431205.0 28319.9 30844.2 31234.4 31492.5 32188.4 45764.5 46645.5 46886.5 46996.5 47352.8 37966.6 38086.0 38102.4 38254.0 39070.2 36801.4 39008.0 39533.4 40990.4 41506.6 41813.4 42351.2 42795.0 42966.8 43498.8 36111.8 36993.6 37014.0 37395.6 37702.0 28717.9 28793.3 29108.3 29167.7 29375.7 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | [#2] jquery.html Cycles:180 Average:30995.13 Median:11479.04 stddev:90808.50 (791.1%) stddev-sans-first:91034.24 03:51:00 INFO - PROCESS | 31289 | Values: 429.6 437.4 438.1 439.0 451.7 18768.6 19182.6 19285.9 20340.8 20855.6 19894.8 20524.9 20652.4 20674.0 20674.1 5679.3 5753.3 5909.6 5914.3 5929.2 4297.0 5794.4 5880.1 6094.9 6409.8 6383.4 6399.1 6408.6 6409.1 6412.8 6146.9 6352.0 6447.8 6458.6 6459.9 4011.4 4171.6 5673.4 5806.5 5824.6 14352.2 14370.7 14560.6 14566.2 21858.5 2329.5 2360.0 2492.1 2494.3 2573.8 10904.5 11274.5 12373.9 13798.4 15440.5 2026.1 2028.7 2074.4 2139.6 2163.9 78167.6 78399.6 80994.0 81033.6 84365.0 10693.3 11177.1 11245.0 11323.3 11476.8 15845.9 15966.3 16043.8 16069.8 16087.0 8592.5 8618.6 8832.8 8866.4 8879.6 8674.1 8677.7 8761.8 8823.7 8915.3 5082.6 5153.0 5154.9 5159.0 5198.8 1899.0 1990.7 2013.9 2031.7 2102.5 989.4 1007.7 1095.0 1110.9 1124.1 19104.7 19182.9 19433.1 19433.2 19489.8 1074.2 1076.5 1102.3 1130.8 1131.4 10241.6 10955.9 10971.5 10985.5 11097.0 536432.0 544171.0 549897.0 558991.0 565968.0 97261.0 98017.0 98976.0 104866.5 110897.4 1081.5 1093.9 1112.7 1118.4 1126.7 17273.2 17320.1 17491.8 17711.0 17738.4 40848.8 41000.4 41592.8 41608.6 41877.2 59043.7 61058.0 61983.0 62259.0 62485.0 8090.1 8118.5 8128.7 8190.0 8387.2 12251.1 12379.9 12857.2 12956.2 13039.9 11037.6 11113.8 11299.8 11531.7 11589.1 10818.5 10916.9 11343.2 11470.5 11484.4 10896.0 10909.6 11287.4 11423.3 11462.1 8052.5 8082.3 8133.5 8172.3 8468.9 9452.0 10410.1 10765.5 10938.0 11049.9 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | [#3] mootools.html Cycles:180 Average:5828.74 Median:2733.63 stddev:3243.31 (118.6%) stddev-sans-first:3235.33 03:51:00 INFO - PROCESS | 31289 | Values: 1400.2 1474.8 1557.4 1723.0 1792.9 8120.9 8430.4 8444.1 8445.8 8463.6 8360.2 8539.0 8539.1 8542.5 8543.6 2123.4 2421.3 2444.9 2468.5 2482.4 2446.1 2467.0 2475.0 2478.1 2482.3 2411.4 2439.8 2443.3 2444.1 2445.1 2106.7 2386.9 2439.7 2442.7 2447.7 2313.7 2341.8 2354.6 2356.2 2368.5 8496.4 8565.0 8565.7 8573.5 8582.5 5382.7 5493.9 5537.7 5544.3 5560.0 3523.9 3530.5 3602.3 3604.1 3644.5 1206.1 1214.6 1234.3 1294.7 1298.7 12390.4 12417.1 12446.2 12450.7 12455.8 4768.3 4788.2 4796.4 4814.4 4898.8 10449.7 10557.3 10586.1 10605.0 10608.5 4780.3 5546.6 5551.5 5551.9 5554.4 4905.0 4974.5 4986.5 4998.6 5045.4 4115.3 4157.2 4168.3 4213.3 4224.9 1354.3 1364.7 1381.3 1387.2 1389.0 1052.0 1063.3 1064.2 1065.1 1083.8 6157.5 6221.1 6258.3 6321.5 6371.8 492.8 502.6 507.5 508.7 514.0 4087.3 4098.0 4148.9 4156.9 4180.4 10466.2 10815.6 10949.1 10974.6 10988.2 10726.6 10757.5 10757.7 10783.4 10799.2 8270.0 8329.5 8438.4 8441.5 8442.6 5948.1 5990.9 6022.6 6065.7 6155.3 9494.7 9661.7 9735.9 9768.8 9774.5 9644.5 9919.9 10035.4 10261.3 10264.6 7461.8 7646.0 7694.8 7890.5 7920.6 8351.7 8363.3 8368.2 8373.3 8402.8 7507.2 7616.0 7637.1 7730.9 7786.7 7481.7 7555.5 7565.4 7604.7 7719.2 7170.8 7177.0 7222.1 7257.6 7258.2 5052.3 5129.8 5196.6 5210.1 5219.1 5266.2 5269.3 5301.2 5314.8 5364.0 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | [#4] prototype.html Cycles:180 Average:5519.23 Median:6270.62 stddev:1667.49 (26.6%) stddev-sans-first:1626.69 03:51:00 INFO - PROCESS | 31289 | Values: 365.7 365.9 366.8 370.2 372.8 6090.6 6177.6 6205.7 6223.3 6238.5 6150.9 6183.0 6185.1 6187.7 6191.7 4532.5 4660.8 4751.4 4756.7 4763.0 4750.6 4771.5 4772.1 4777.7 4779.1 4718.1 4723.3 4723.6 4734.6 4736.8 4490.6 4595.7 4688.2 4732.0 4740.5 4134.2 4140.2 4143.8 4148.1 4153.8 5865.9 5947.4 5953.0 5967.0 5976.8 5508.1 5515.6 5521.3 5521.9 5543.0 6537.0 6546.9 6553.8 6554.0 6556.1 4561.6 4637.4 4641.7 4651.7 4657.3 6760.1 6824.6 6828.2 6835.8 6840.1 4761.5 4765.9 4768.1 4773.6 4777.9 4826.5 4828.3 4832.7 4835.5 4841.5 5514.8 5523.6 5523.9 5532.6 5535.1 6323.2 6523.2 6556.1 6556.5 6567.6 1630.4 1631.3 1636.6 1642.9 1643.1 1080.8 1093.1 1102.4 1103.8 1108.4 6183.5 6302.8 6304.0 6376.4 6385.7 6727.4 6807.5 6820.3 6821.4 6825.2 6455.5 6463.7 6465.1 6471.3 6472.7 3578.5 3647.3 3648.5 3650.4 3651.2 6959.3 7075.9 7082.3 7102.2 7124.0 6864.6 6895.7 6899.8 6908.9 6910.3 7068.2 7090.0 7091.4 7099.5 7102.0 6765.1 6768.8 6785.1 6786.4 6792.6 6606.3 6703.1 6704.9 6771.5 6774.4 7109.9 7147.9 7150.0 7152.9 7157.0 4560.9 4586.7 4587.3 4588.3 4591.5 6795.7 6796.5 6800.2 6801.6 6801.9 6461.7 6640.2 6645.9 6647.3 6669.8 6591.1 6596.0 6613.6 6629.3 6663.6 6499.2 6500.5 6503.8 6519.0 6523.9 6633.2 6639.5 6650.2 6652.8 6661.7 6384.0 6480.3 6484.9 6491.7 6517.3 03:51:00 INFO - PROCESS | 31289 | 03:51:00 INFO - PROCESS | 31289 | [#5] yui.html Cycles:180 Average:15264.27 Median:4760.41 stddev:17398.91 (365.5%) stddev-sans-first:17413.97 03:51:00 INFO - PROCESS | 31289 | Values: 833.2 847.7 854.9 855.3 859.0 14860.4 15101.8 15166.9 15192.5 15237.2 13652.7 13668.8 13748.2 13758.7 13834.1 732.9 866.1 880.9 889.5 896.2 886.8 887.3 891.3 891.4 891.7 933.8 934.1 934.3 935.6 935.9 781.2 788.8 789.5 908.2 929.3 687.0 687.2 687.6 689.0 689.1 14273.6 14408.4 14433.6 14445.9 14452.3 13630.8 13684.2 14045.5 14257.9 14545.1 11219.8 11333.0 11834.2 12114.0 12271.0 4694.2 4708.4 4749.4 4771.5 4789.6 54812.7 55219.7 55235.4 55318.0 55414.2 10376.4 10656.9 11554.7 11756.4 11960.3 19246.4 19295.2 19419.0 19497.9 19517.7 8599.7 8618.1 8623.0 8693.7 8911.9 4967.2 4968.3 4972.9 5082.4 5133.2 3667.8 3668.5 3673.3 3674.7 3678.4 677.8 687.0 687.1 694.4 714.2 650.6 660.1 688.2 742.6 783.4 9346.8 9654.8 9715.2 9961.8 9964.6 716.2 738.4 756.8 762.8 812.7 4491.4 4535.6 4573.1 4575.8 4614.7 63008.0 63993.0 64081.7 64237.7 64296.0 55973.7 56542.2 57054.7 57192.7 57605.7 47902.0 48290.5 48337.0 48443.5 48634.5 9667.5 9785.7 9815.9 9878.4 9961.4 36334.8 36350.8 37388.8 37759.2 37938.0 42228.7 46607.0 47420.5 47974.8 50423.0 11894.0 11923.7 11928.5 12053.2 12324.9 13037.6 13042.6 13086.3 13350.5 13643.2 10873.4 11124.9 13267.4 13790.0 13853.2 13463.7 13559.1 13636.7 13709.3 13736.6 13110.8 13528.0 13813.7 13898.3 14278.6 11087.3 11128.8 11201.3 11342.3 11448.9 11190.4 11426.5 11670.4 11680.4 11758.3 03:51:00 INFO - PROCESS | 31289 | -------- Summary: end -------- 03:51:00 INFO - PROCESS | 31289 | 03:51:01 INFO - TEST-INFO | 31289: exit 0 03:51:01 INFO - TEST-OK | dromaeo_css | took 1110739ms 03:51:01 INFO - TEST-START | kraken 03:51:01 INFO - operating with platform_type : linux_ 03:51:01 INFO - Initialising browser for kraken test... 03:51:01 INFO - TEST-INFO | started process 31474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuex1Tp/profile http://localhost:50484/getInfo.html) 03:51:05 INFO - PROCESS | 31474 | __metrics Screen width/height:1600/1200 03:51:05 INFO - PROCESS | 31474 | colorDepth:24 03:51:05 INFO - PROCESS | 31474 | Browser inner width/height: 1024/697 03:51:05 INFO - PROCESS | 31474 | __metrics 03:51:06 ERROR - PROCESS | 31474 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:51:06 INFO - TEST-INFO | 31474: exit 0 03:51:06 INFO - Browser initialized. 03:51:06 INFO - Running cycle 1/1 for kraken test... 03:51:06 INFO - TEST-INFO | started process 31568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuex1Tp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:18 INFO - PROCESS | 31568 | RSS: Main: 142151680 03:51:18 INFO - PROCESS | 31568 | 03:51:21 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:22 INFO - PROCESS | 31568 | RSS: Main: 197107712 03:51:22 INFO - PROCESS | 31568 | 03:51:24 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-dft) 03:51:25 INFO - PROCESS | 31568 | RSS: Main: 182358016 03:51:25 INFO - PROCESS | 31568 | 03:51:28 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-fft) 03:51:28 INFO - PROCESS | 31568 | RSS: Main: 273379328 03:51:28 INFO - PROCESS | 31568 | 03:51:30 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-oscillator) 03:51:31 INFO - PROCESS | 31568 | RSS: Main: 179269632 03:51:31 INFO - PROCESS | 31568 | 03:51:33 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50484/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:34 INFO - PROCESS | 31568 | RSS: Main: 177340416 03:51:34 INFO - PROCESS | 31568 | 03:51:37 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50484/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:37 INFO - PROCESS | 31568 | RSS: Main: 212254720 03:51:37 INFO - PROCESS | 31568 | 03:51:41 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50484/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:41 INFO - PROCESS | 31568 | RSS: Main: 212525056 03:51:41 INFO - PROCESS | 31568 | 03:51:44 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50484/tests/kraken/driver.html?testName=json-parse-financial) 03:51:44 INFO - PROCESS | 31568 | RSS: Main: 212361216 03:51:44 INFO - PROCESS | 31568 | 03:51:46 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50484/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:47 INFO - PROCESS | 31568 | RSS: Main: 190681088 03:51:47 INFO - PROCESS | 31568 | 03:51:48 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:49 INFO - PROCESS | 31568 | RSS: Main: 196837376 03:51:49 INFO - PROCESS | 31568 | 03:51:51 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:51 INFO - PROCESS | 31568 | RSS: Main: 209928192 03:51:51 INFO - PROCESS | 31568 | 03:51:54 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:54 INFO - PROCESS | 31568 | RSS: Main: 213819392 03:51:54 INFO - PROCESS | 31568 | 03:51:57 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:58 INFO - PROCESS | 31568 | RSS: Main: 211079168 03:51:58 INFO - PROCESS | 31568 | 03:51:59 INFO - PROCESS | 31568 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50484/tests/kraken/driver.html?testName=ai-astar) 03:52:00 INFO - PROCESS | 31568 | RSS: Main: 275505152 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | __start_tp_report 03:52:00 INFO - PROCESS | 31568 | _x_x_mozilla_page_load 03:52:00 INFO - PROCESS | 31568 | _x_x_mozilla_page_load_details 03:52:00 INFO - PROCESS | 31568 | |i|pagename|runs| 03:52:00 INFO - PROCESS | 31568 | |0;ai-astar;110;110;110;110;110;110;105;110;110;110 03:52:00 INFO - PROCESS | 31568 | |1;audio-beat-detection;172;131;158;172;128;150;152;128;175;127 03:52:00 INFO - PROCESS | 31568 | |2;audio-dft;162;162;159;161;160;162;161;161;161;163 03:52:00 INFO - PROCESS | 31568 | |3;audio-fft;76;76;77;176;77;77;77;75;167;76 03:52:00 INFO - PROCESS | 31568 | |4;audio-oscillator;93;92;148;92;92;92;156;91;92;144 03:52:00 INFO - PROCESS | 31568 | |5;imaging-gaussian-blur;117;116;117;118;117;116;116;117;117;116 03:52:00 INFO - PROCESS | 31568 | |6;imaging-darkroom;144;145;146;145;145;146;146;145;145;146 03:52:00 INFO - PROCESS | 31568 | |7;imaging-desaturate;95;94;95;95;94;94;94;94;95;95 03:52:00 INFO - PROCESS | 31568 | |8;json-parse-financial;55;55;54;55;55;54;57;67;54;53 03:52:00 INFO - PROCESS | 31568 | |9;json-stringify-tinderbox;58;58;57;57;58;59;58;59;58;58 03:52:00 INFO - PROCESS | 31568 | |10;stanford-crypto-aes;73;74;73;80;73;74;73;73;73;81 03:52:00 INFO - PROCESS | 31568 | |11;stanford-crypto-ccm;117;115;121;114;111;110;111;111;135;137 03:52:00 INFO - PROCESS | 31568 | |12;stanford-crypto-pbkdf2;159;163;156;157;160;158;157;158;154;160 03:52:00 INFO - PROCESS | 31568 | |13;stanford-crypto-sha256-iterative;67;68;65;66;64;66;65;65;66;64 03:52:00 INFO - PROCESS | 31568 | __end_tp_report 03:52:00 INFO - PROCESS | 31568 | __start_cc_report 03:52:00 INFO - PROCESS | 31568 | _x_x_mozilla_cycle_collect,1567 03:52:00 INFO - PROCESS | 31568 | __end_cc_report 03:52:00 INFO - PROCESS | 31568 | __startTimestamp1463741520161__endTimestamp 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | ------- Summary: start ------- 03:52:00 INFO - PROCESS | 31568 | Number of tests: 14 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 03:52:00 INFO - PROCESS | 31568 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 105.0 110.0 110.0 110.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:155.00 stddev:19.76 (12.7%) stddev-sans-first:19.18 03:52:00 INFO - PROCESS | 31568 | Values: 172.0 131.0 158.0 172.0 128.0 150.0 152.0 128.0 175.0 127.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 03:52:00 INFO - PROCESS | 31568 | Values: 162.0 162.0 159.0 161.0 160.0 162.0 161.0 161.0 161.0 163.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.50 stddev:40.17 (52.5%) stddev-sans-first:41.99 03:52:00 INFO - PROCESS | 31568 | Values: 76.0 76.0 77.0 176.0 77.0 77.0 77.0 75.0 167.0 76.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.85 (30.3%) stddev-sans-first:28.91 03:52:00 INFO - PROCESS | 31568 | Values: 93.0 92.0 148.0 92.0 92.0 92.0 156.0 91.0 92.0 144.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:52:00 INFO - PROCESS | 31568 | Values: 117.0 116.0 117.0 118.0 117.0 116.0 116.0 117.0 117.0 116.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 03:52:00 INFO - PROCESS | 31568 | Values: 144.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:52:00 INFO - PROCESS | 31568 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:4.04 (7.3%) stddev-sans-first:4.27 03:52:00 INFO - PROCESS | 31568 | Values: 55.0 55.0 54.0 55.0 55.0 54.0 57.0 67.0 54.0 53.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 03:52:00 INFO - PROCESS | 31568 | Values: 58.0 58.0 57.0 57.0 58.0 59.0 58.0 59.0 58.0 58.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:73.50 stddev:3.09 (4.2%) stddev-sans-first:3.22 03:52:00 INFO - PROCESS | 31568 | Values: 73.0 74.0 73.0 80.0 73.0 74.0 73.0 73.0 73.0 81.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:116.00 stddev:9.98 (8.6%) stddev-sans-first:10.57 03:52:00 INFO - PROCESS | 31568 | Values: 117.0 115.0 121.0 114.0 111.0 110.0 111.0 111.0 135.0 137.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.50 stddev:2.49 (1.6%) stddev-sans-first:2.62 03:52:00 INFO - PROCESS | 31568 | Values: 159.0 163.0 156.0 157.0 160.0 158.0 157.0 158.0 154.0 160.0 03:52:00 INFO - PROCESS | 31568 | 03:52:00 INFO - PROCESS | 31568 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 03:52:00 INFO - PROCESS | 31568 | Values: 67.0 68.0 65.0 66.0 64.0 66.0 65.0 65.0 66.0 64.0 03:52:00 INFO - PROCESS | 31568 | -------- Summary: end -------- 03:52:00 INFO - PROCESS | 31568 | 03:52:01 INFO - TEST-INFO | 31568: exit 0 03:52:01 INFO - TEST-OK | kraken | took 59601ms 03:52:01 INFO - SUITE-END | took 1170s 03:52:01 INFO - Completed test suite (00:19:30) 03:52:01 INFO - javascript benchmark 03:52:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.7859039162454, 3361.4789707595332, 3366.1584603849046, 3381.594208694957, 3392.5420068290787, 5473.124300111978, 5508.614396992212, 5513.228148059265, 5513.979913715965, 5519.144532597449, 5523.7790488380415, 5547.223388725572, 5553.72231388431, 5563.443655634434, 5583.190437386576, 4870.050340183666, 4998.950010499894, 5041.8235361762345, 5128.282040514331, 5156.04613146569, 4836.105320515699, 4899.510048995107, 4902.558769710726, 4902.583280421169, 4912.38595175603, 4912.828051018215, 5035.144025515671, 5091.083604951107, 5121.564667003309, 5125.231215317714, 5041.344625198719, 5066.214736715778, 5080.974595127038, 5087.287779710843, 5116.539511443988, 4910.533499317559, 4943.1596628573225, 4997.85006449807, 5004.224345226496, 5010.69935803853, 5440.564754819605, 5463.508284254436, 5471.808486702986, 5489.204065410533, 5492.505674489315, 5783.624064435799, 5791.913121303184, 5821.767129314822, 5846.918320110751, 5847.795327163529, 5806.042003069489, 5841.649501029951, 5887.7635696503785, 5906.084556893688, 5943.4056594340655, 5441.102218134043, 5476.4249753775675, 5484.698341591211, 5487.204355368449, 5492.917606235909, 5762.538996880239, 5964.045752679637, 5968.970155149196, 5969.283685957713, 5986.850328741816, 5709.68596727184, 5726.627769195073, 5729.799457019068, 5731.283589551306, 5753.309602847601, 5849.473547380756, 5850.297964244232, 5852.531797456193, 5853.824385268449, 5858.091995740667, 5639.154126880919, 5821.708914554255, 5824.388439213906, 5826.067829147316, 5867.295924489089, 5822.592418530747, 5850.853728656818, 5854.736536855852, 5885.382034886361, 5901.17383566301, 4490.146872094291, 4509.503954564995, 4509.909801803946, 4511.323301504735, 4534.750588717652, 3956.188981258835, 3993.4209539616595, 4026.315526360526, 4067.247559201557, 4076.021754778891, 5535.861603459945, 5565.026120428909, 5569.721513924369, 5575.219469274305, 5590.86022849432, 5902.675352855548, 5921.259842519685, 5923.348431672513, 5927.970360148258, 5933.732982015733, 5412.83761487156, 5558.305211848519, 5609.775608975677, 5645.294338207724, 5717.542596592262, 5105.923411148836, 5107.438181799999, 5123.769430375642, 5130.256112863613, 5137.049645815536, 6131.294901086432, 6137.754489820447, 6139.10982907476, 6139.447449729546, 6140.385961403913, 5723.942760572508, 5841.4450627190345, 5919.704014799329, 5922.437368449991, 5950.732217050329, 6099.512039036777, 6143.648397352576, 6145.66198859067, 6147.938520614915, 6148.385161483816, 5799.739011744397, 5804.361520232686, 5812.912806307993, 5813.0, 5825.3592104867585, 5793.913091303718, 5914.142449344907, 5926.733297001559, 6007.068904319837, 6012.909806352821, 5791.681457519877, 5809.331926828469, 5814.5348372130975, 5815.41845815415, 5815.9709201453725, 5732.656040637575, 5770.942290577041, 5779.104238842986, 5786.161006654096, 5789.2763404574425, 5533.474319939599, 5740.51205647508, 5811.79658711943, 5813.534917206698, 5827.155062515996, 5795.652260864362, 5826.82519524415, 5828.358880523224, 5831.94168058331, 5834.708264586839, 5454.672719636835, 5636.661800291996, 5698.088305871041, 5704.942950570441, 5721.456461636304], "value": 5437.171954818527, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.1714673804483, 672.7510820996231, 682.123471339329, 685.3523420367749, 738.0294912190473, 33882.491762623584, 34528.82735586321, 34539.30921381571, 40754.38868416969, 41393.17213655725, 44139.0, 44764.0, 44785.55214447855, 44794.77602611991, 44845.0, 8810.647574097044, 8974.28205743539, 8987.685431009915, 8989.280857531381, 8995.100489950984, 8845.115488451136, 8952.910470895273, 8976.685815996441, 8977.685780997634, 8980.775480612972, 8954.37319387643, 9021.36850420471, 9173.44959302444, 9200.677976270832, 9200.907990920072, 9098.363114581982, 9114.498702571356, 9143.817123657556, 9151.405158664666, 9154.084591540826, 9067.0, 9185.49479778612, 9203.493807840567, 9204.125608067223, 9209.263258939269, 44157.55842441566, 44190.558094418964, 44327.335089973676, 44336.77831610854, 44671.0, 3793.1655035892336, 3868.3810590305698, 4000.699947503949, 4424.137293227822, 4655.045715628288, 31064.0, 31155.53266701001, 31230.53154202689, 31264.843675781703, 32341.83829080863, 4635.930461043087, 4660.300954856764, 4687.484376718558, 4704.506026867164, 4707.176244157259, 226171.0, 231077.0, 231282.0, 231353.9999999983, 231401.0, 40122.1975560493, 58930.41069589335, 64274.500784944605, 64276.0, 64295.35704642894, 39130.608693913266, 39192.0, 39256.60743392586, 39397.212055758726, 39468.0, 16754.1622918856, 17033.574160646083, 17060.91469542669, 17076.402325918534, 17078.658426831393, 13829.10110842792, 13830.37763300654, 13900.16599004063, 13933.651658708613, 13950.23273719955, 9381.29640276982, 9395.671151509665, 9518.666846660471, 9528.333016688764, 9546.140847323773, 3533.222691007974, 3600.3339382214376, 3618.87333943316, 3638.0541059324764, 3642.745007849478, 1070.3310430980637, 1145.8109411947103, 1170.7365842685329, 1176.2589568571746, 1210.3040751567883, 34801.65198347984, 35269.17679376563, 35465.46801797975, 35498.29003419917, 35704.82147589245, 1234.5370486067725, 1234.8947691815954, 1235.2650173146963, 1235.950561977511, 1240.34881687115, 17834.19746111428, 18400.447986560426, 18459.446216613524, 18513.629727405376, 18567.53581160482, 466848.0, 473081.0, 473243.0, 473668.0, 473867.0, 61176.38823611796, 61676.0, 61861.38138618646, 62177.067343989875, 62342.688286558274, 1438.4318194313187, 1453.3532578002687, 1478.608168835238, 1504.9623759405883, 1514.8788096952217, 33745.0, 34247.486287706204, 34367.48448773321, 34619.48070778991, 34706.65293347135, 55838.162427562806, 55906.0, 56274.0, 56374.718126409105, 56387.43612563822, 426446.0, 428569.0, 430537.0, 430543.0, 431205.0, 28319.858400707864, 30844.22889427782, 31234.375312493168, 31492.527612085378, 32188.356232875678, 45764.54235457603, 46645.53354466412, 46886.53113468958, 46996.53003470058, 47352.7632361836, 37966.62033379631, 38086.0, 38102.428463573626, 38254.0, 39070.218595628496, 36801.447978280885, 39008.0, 39533.40699889446, 40990.385144222266, 41506.58493415027, 41813.372799408644, 42351.1529769409, 42795.0, 42966.78516607397, 43498.782506087264, 36111.819440902626, 36993.63006369902, 37014.0, 37395.6260437403, 37702.0, 28717.856410717814, 28793.280167995967, 29108.27229319284, 29167.708322917348, 29375.70624293815], "value": 19481.8616408613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.5747210261841, 437.39639297769077, 438.13468399910164, 439.0246319576238, 451.68607817566783, 18768.62462750744, 19182.616347673054, 19285.903570482147, 20340.796592034076, 20855.582888342262, 19894.801051989474, 20524.897375513137, 20652.380428587167, 20674.0, 20674.06966686499, 5679.346875109374, 5753.338366087912, 5909.586328956974, 5914.319853216871, 5929.229200203968, 4296.957030429702, 5794.362620111805, 5880.147378630096, 6094.908576371358, 6409.839754006164, 6383.425491705745, 6399.136116624242, 6408.551401401904, 6409.102725618417, 6412.839679008039, 6146.877062458748, 6352.0, 6447.83880402989, 6458.612483250997, 6459.870802583922, 4011.358182690785, 4171.645410140141, 5673.375928647845, 5806.477417032487, 5824.563157763185, 14352.210628415432, 14370.712585748332, 14560.635984100376, 14566.198859062748, 21858.453538661503, 2329.4758679297192, 2359.988200059006, 2492.0654754467073, 2494.3390001649577, 2573.7812285955715, 10904.50929708165, 11274.549018039268, 12373.876261237363, 13798.448062077505, 15440.459583914622, 2026.092260089565, 2028.7471891747214, 2074.3776866940007, 2139.5827813576357, 2163.8809865457392, 78167.6091619544, 78399.6080019602, 80994.0, 81033.59483202605, 84365.0, 10693.251472397013, 11177.105831533621, 11245.0, 11323.32060076398, 11476.827847582126, 15845.920770396306, 15966.281517331749, 16043.759343609856, 16069.758953615705, 16087.0, 8592.52741099233, 8618.569071546523, 8832.823343533093, 8866.379353445196, 8879.556022198993, 8674.08922063187, 8677.6528938843, 8761.75814948473, 8823.735287941372, 8915.28677705782, 5082.618803589746, 5153.0, 5154.871128221749, 5159.045576568347, 5198.766055527511, 1899.0, 1990.711346854727, 2013.8791672499403, 2031.7460317460318, 2102.495401103755, 989.4310771306527, 1007.7077647482295, 1094.950727217277, 1110.8666959964694, 1124.0726400719439, 19104.713429298572, 19182.904085479484, 19433.12550935183, 19433.222671092997, 19489.830610163437, 1074.2050882347007, 1076.5263284154946, 1102.3441052573705, 1130.7625398666207, 1131.4399372310759, 10241.641542545975, 10955.890441095646, 10971.506282217319, 10985.505652245509, 11097.00126988575, 536432.0, 544171.0, 549897.0, 558991.0, 565968.0, 97261.0, 98017.0, 98976.0, 104866.47566762117, 110897.44551277193, 1081.5133190064346, 1093.94530273486, 1112.694009147491, 1118.4062710637309, 1126.6845283320683, 17273.222704978558, 17320.13399330003, 17491.825081749528, 17711.0, 17738.379156729454, 40848.79575602103, 41000.38499422571, 41592.792036039624, 41608.583914160474, 41877.162456751306, 59043.70478147582, 61058.0, 61983.0, 62259.0, 62485.0, 8090.11008789021, 8118.472299300763, 8128.715494957648, 8189.959050204711, 8387.245147936716, 12251.142420030512, 12379.876201237872, 12857.228566286052, 12956.222626642431, 13039.934800325938, 11037.613683521038, 11113.833292500458, 11299.774004519699, 11531.711707207387, 11589.130815189063, 10818.513166907665, 10916.945415272872, 11343.20597558163, 11470.483828227916, 11484.368359740294, 10896.0, 10909.618163364245, 11287.43562821872, 11423.257488263236, 11462.14033947474, 8052.476589021695, 8082.2725954664365, 8133.471324363897, 8172.305354044973, 8468.872966905377, 9452.0, 10410.115140213167, 10765.515551800345, 10938.0, 11049.889501105208], "value": 9442.683230527085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.2088819816809, 1474.7714104313832, 1557.4393218441362, 1722.9655406891864, 1792.9282828686853, 8120.878186827195, 8430.409871308995, 8444.071152173256, 8445.78885527862, 8463.57682115894, 8360.205780450862, 8538.957305213466, 8539.146085391458, 8542.487450752944, 8543.57282135894, 2123.3948324727457, 2421.2615152378517, 2444.8655323957173, 2468.4816188600416, 2482.404222986488, 2446.1438496526252, 2466.987665061672, 2474.9752502474926, 2478.10788116278, 2482.2925466242123, 2411.3850968003135, 2439.7682220189054, 2443.2670198940336, 2444.083468699238, 2445.070873068232, 2106.6524023536176, 2386.940326491843, 2439.658447817307, 2442.694663167113, 2447.6695646087906, 2313.745487996319, 2341.824363172752, 2354.587947109249, 2356.163561935505, 2368.538135063663, 8496.447730897471, 8564.957175214084, 8565.743027709179, 8573.52845593492, 8582.485050896903, 5382.67703937765, 5493.862653433656, 5537.667739935617, 5544.306961629796, 5559.972200139014, 3523.894283171509, 3530.4704294355797, 3602.2975519773654, 3604.098975256186, 3644.4715516249994, 1206.1255589697487, 1214.574898785418, 1234.3026190202597, 1294.6828027133317, 1298.6623477895814, 12390.442430090667, 12417.130800843945, 12446.190997585129, 12450.688732781753, 12455.75088498225, 4768.283417969528, 4788.233882578771, 4796.448408433005, 4814.398200224972, 4898.779554919965, 10449.746030476239, 10557.260991730658, 10586.100181484506, 10605.045545900752, 10608.522616482276, 4780.282957556325, 5546.58400619947, 5551.528120109755, 5551.8889622207325, 5554.444555544414, 4904.950950490521, 4974.502549744997, 4986.526280003394, 4998.600111991032, 5045.369328833895, 4115.279826030433, 4157.210130075337, 4168.291390463629, 4213.2837417639075, 4224.936625950613, 1354.2889982758934, 1364.7065880835669, 1381.3369582600408, 1387.1506569270355, 1389.0, 1051.9737006574896, 1063.2769716592636, 1064.2497039587072, 1065.0521036277719, 1083.8374243863325, 6157.476614487729, 6221.09794079865, 6258.3428739982555, 6321.462675672527, 6371.776987805404, 492.7582492119838, 502.5602597726989, 507.51785803486837, 508.73545756207307, 513.9640225184276, 4087.305158123126, 4097.959020409818, 4148.91702165955, 4156.896077598084, 4180.435641188462, 10466.162706983423, 10815.621453249098, 10949.069329106957, 10974.615888444026, 10988.230823842414, 10726.570937162582, 10757.515911783988, 10757.731056723644, 10783.406912619881, 10799.244052916378, 8270.048944371474, 8329.458585191944, 8438.36712246584, 8441.493510389519, 8442.62008209632, 5948.078047902582, 5990.850228744316, 6022.5784195105925, 6065.665553578206, 6155.292141403616, 9494.715158545254, 9661.661841835503, 9735.9026409735, 9768.755781105529, 9774.511274436392, 9644.469554174588, 9919.900800991898, 10035.397876127456, 10261.333013354108, 10264.589416423558, 7461.813454663677, 7645.961770191114, 7694.846103077795, 7890.526568405914, 7920.603969801602, 8351.665933362598, 8363.289120424832, 8368.205020523284, 8373.288270496832, 8402.831943361221, 7507.174210836913, 7616.04799400075, 7637.121731001006, 7730.884036739341, 7786.688532458638, 7481.66332515049, 7555.471117021756, 7565.43259255547, 7604.733834315994, 7719.189485103983, 7170.820729481805, 7176.96411517939, 7222.133343998754, 7257.637118144177, 7258.237885022208, 5052.267421223828, 5129.846104616868, 5196.558292545176, 5210.140326846028, 5219.112750832443, 5266.183741520071, 5269.314989051399, 5301.1783173608155, 5314.760835762323, 5364.034473794754], "value": 4654.6139541886705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.72753298792406, 365.87011610878136, 366.8495916674164, 370.1578907984336, 372.83595218104017, 6090.634561926282, 6177.567570270077, 6205.689715514218, 6223.284322302937, 6238.469730072938, 6150.938490615093, 6183.010718285075, 6185.134081228632, 6187.65967871768, 6191.721372538235, 4532.546745325474, 4660.813567457298, 4751.40607424072, 4756.714597124166, 4763.0, 4750.643701722367, 4771.451283102436, 4772.093302272575, 4777.689450185744, 4779.115863565252, 4718.079974404993, 4723.338732577442, 4723.5512626300615, 4734.55021772931, 4736.810527578893, 4490.57339552742, 4595.747233902134, 4688.156131896258, 4732.0, 4740.478547359788, 4134.152498737752, 4140.171965606861, 4143.81352839123, 4148.149629325981, 4153.792310384469, 5865.912011319833, 5947.4052594740615, 5953.047512398039, 5967.045272756382, 5976.760929562813, 5508.063629183049, 5515.586331025149, 5521.254630624894, 5521.917171242435, 5543.0, 6536.9673151634415, 6546.9017964730565, 6553.803385898431, 6554.0, 6556.114924485181, 4561.589456948891, 4637.397138372024, 4641.698289611199, 4651.674382793206, 4657.347971284023, 6760.0535924970545, 6824.556403833735, 6828.180618325832, 6835.7949261522235, 6840.144981877265, 4761.52384761528, 4765.8570242892765, 4768.0702263059065, 4773.618110551148, 4777.928331075037, 4826.541478559531, 4828.251620998681, 4832.710037397697, 4835.468098509161, 4841.491643377394, 5514.779408823682, 5523.585731070186, 5523.861903452445, 5532.585056120807, 5535.142052981794, 6323.177986861679, 6523.217213934264, 6556.114924485229, 6556.475481961432, 6567.605943643397, 1630.4049022106847, 1631.331154226785, 1636.5925304238347, 1642.852143307108, 1643.0962970366252, 1080.8324709669857, 1093.1418836213534, 1102.366139469808, 1103.812351900179, 1108.4180805077237, 6183.505319574423, 6302.779402720883, 6304.0, 6376.39424254695, 6385.722855428933, 6727.360900714424, 6807.4894382921475, 6820.31796820324, 6821.386075253251, 6825.215100263434, 6455.515231496688, 6463.7091330890225, 6465.094886715863, 6471.288158302583, 6472.676366181766, 3578.481120237551, 3647.2705458908326, 3648.4527320901548, 3650.4341827016856, 3651.1784848408897, 6959.338862808025, 7075.893861592081, 7082.291770822876, 7102.218755936843, 7124.0, 6864.622445765531, 6895.724171033103, 6899.793006209822, 6908.9309106909295, 6910.2744211858035, 7068.187158476738, 7090.0, 7091.432685385157, 7099.538529995637, 7101.964490177619, 6765.1205343305055, 6768.830779230559, 6785.050092986887, 6786.423154031962, 6792.558483698544, 6606.306337834651, 6703.061571380108, 6704.899426508508, 6771.52599318043, 6774.424173945073, 7109.893351599627, 7147.8570428592175, 7150.0, 7152.928470715435, 7156.964215178891, 4560.931586026279, 4586.656000799887, 4587.334836448629, 4588.311753237042, 4591.494935557019, 6795.72817087311, 6796.490263230178, 6800.217974932946, 6801.591904485549, 6801.931980680328, 6461.741530338733, 6640.169978752656, 6645.933540664725, 6647.302033286435, 6669.7665581704405, 6591.077249185214, 6596.0, 6613.603183808795, 6629.3039230882, 6663.633500157538, 6499.1876015498065, 6500.5449618526245, 6503.837404064936, 6518.967405162944, 6523.934760652332, 6633.170853643294, 6639.502037347315, 6650.235222949423, 6652.76715314981, 6661.666916654245, 6383.968080159755, 6480.25477070143, 6484.935150648622, 6491.707873145814, 6517.348265173634], "value": 4979.862720734393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.2380445752523, 847.7287268074215, 854.8674955381916, 855.3220312167824, 858.9999999999998, 14860.40558377665, 15101.848981510182, 15166.924165379172, 15192.544223673307, 15237.16195609241, 13652.72694546111, 13668.794968075463, 13748.175109493437, 13758.656033599165, 13834.100783449068, 732.8717474441978, 866.0516734176067, 880.903100658927, 889.4663202078766, 896.224765577777, 886.7738726624734, 887.2857349833381, 891.3136884598855, 891.4072142025577, 891.7191084808264, 933.8225737109927, 934.0939288889766, 934.3272843552631, 935.6117211357279, 935.9017303183169, 781.2031727637806, 788.8382881509277, 789.4710543935548, 908.2053203446984, 929.3308817651314, 686.989695154568, 687.2303020616891, 687.6114995027793, 689.0, 689.1351354050635, 14273.643158921006, 14408.351624176832, 14433.566992990227, 14445.927770361186, 14452.277386130652, 13630.795538066937, 13684.247366394844, 14045.508407205698, 14257.857421425757, 14545.054571452822, 11219.831702524469, 11333.0, 11834.171607987444, 12114.0, 12271.0, 4694.201985662411, 4708.434987801452, 4749.358836557055, 4771.451283102453, 4789.56893879549, 54812.725936370465, 55219.72390138024, 55235.44764552343, 55318.0, 55414.16878746782, 10376.429296388771, 10656.946715266375, 11554.711132221593, 11756.35340056288, 11960.342181179945, 19246.4226073218, 19295.228190872207, 19419.029048547516, 19497.902510487358, 19517.707234391495, 8599.656013759379, 8618.138186181332, 8623.0, 8693.739187824376, 8911.910880891108, 4967.205247160437, 4968.254761785761, 4972.8508144755715, 5082.440931497532, 5133.204353325166, 3667.7615954962844, 3668.4680721295795, 3673.3020726062496, 3674.6876515496483, 3678.3746763050344, 677.8136012596477, 686.9725210991504, 687.1273482676972, 694.3924066441863, 714.2072299747276, 650.6193876582253, 660.0528241972785, 688.215434404779, 742.5581778841581, 783.3772151139857, 9346.813063738688, 9654.806903861883, 9715.174210192072, 9961.750956226153, 9964.601415943425, 716.2443621978758, 738.3945164964678, 756.8486302739474, 762.8016715653858, 812.6911773526023, 4491.438570178728, 4535.614472769851, 4573.085382923428, 4575.771211439414, 4614.700044497097, 63008.0, 63993.0, 64081.679591602675, 64237.67881160564, 64296.03555946665, 55973.72013139908, 56542.151867722016, 57054.71472642693, 57192.71403642955, 57605.71197143987, 47902.0, 48290.5170948286, 48337.0, 48443.51556484461, 48634.513654862996, 9667.468289243878, 9785.657501987396, 9815.85276220843, 9878.357906736039, 9961.35251208669, 36334.8183259082, 36350.8182459086, 37388.813055934545, 37759.244815104095, 37938.0, 42228.73313800591, 46607.0, 47420.52579474161, 47974.760126199144, 50423.0, 11894.0, 11923.701907452383, 11928.463219155332, 12053.216540924812, 12324.876751232732, 13037.608871733863, 13042.608721738363, 13086.345682716017, 13350.465981361025, 13643.181409115485, 10873.401962892116, 11124.888751112385, 13267.40296686632, 13790.0, 13853.168809871037, 13463.71116910108, 13559.118657287245, 13636.65908352299, 13709.258148370565, 13736.580516898608, 13110.803337949748, 13528.0, 13813.654658633615, 13898.305084745925, 14278.643033924234, 11087.279326843729, 11128.777424451628, 11201.327920324806, 11342.262752921033, 11448.94275528617, 11190.384528850991, 11426.485808138488, 11670.416479176178, 11680.357580333164, 11758.294502329887], "value": 7070.474561340349, "unit": "score"}], "name": "dromaeo_css", "value": 7398.001266871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 105.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 131.0, 158.0, 172.0, 128.0, 150.0, 152.0, 128.0, 175.0, 127.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 159.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 176.0, 77.0, 77.0, 77.0, 75.0, 167.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 148.0, 92.0, 92.0, 92.0, 156.0, 91.0, 92.0, 144.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 57.0, 67.0, 54.0, 53.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 80.0, 73.0, 74.0, 73.0, 73.0, 73.0, 81.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 121.0, 114.0, 111.0, 110.0, 111.0, 111.0, 135.0, 137.0], "value": 118.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 156.0, 157.0, 160.0, 158.0, 157.0, 158.0, 154.0, 160.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 65.0, 66.0, 64.0, 66.0, 65.0, 65.0, 66.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1511.7000000000003, "alertThreshold": 2.0}]} 03:52:01 INFO - Return code: 0 03:52:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:52:01 ERROR - # TBPL SUCCESS # 03:52:01 INFO - Running post-action listener: _resource_record_post_action 03:52:01 INFO - Running post-run listener: _resource_record_post_run 03:52:02 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 501301248; Read time: 0; Write time: 339028 03:52:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248913920; Read time: 0; Write time: 207960 03:52:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 252387328; Read time: 0; Write time: 131068 03:52:02 INFO - Running post-run listener: _upload_blobber_files 03:52:02 INFO - Blob upload gear active. 03:52:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:52:02 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:52:02 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:52:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:52:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:03 INFO - (blobuploader) - INFO - Done attempting. 03:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:52:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:04 INFO - (blobuploader) - INFO - Done attempting. 03:52:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:04 INFO - Return code: 0 03:52:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67773e5a46da448546d977d991055400b7c9171cec248d97a81247b20cc66c95131eb1779815435dad4aa394e98183ce20a1bb15315c759361cc1dfb4a755a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b258e053fee256e80d9b82991795c34d72459b24fc5685442389e426a6141ef4b1f1f93545a28bb7e51b7b8791a8870e9ab4951e37f99c444b335360b7ff5ed"} 03:52:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:04 INFO - Contents: 03:52:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67773e5a46da448546d977d991055400b7c9171cec248d97a81247b20cc66c95131eb1779815435dad4aa394e98183ce20a1bb15315c759361cc1dfb4a755a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b258e053fee256e80d9b82991795c34d72459b24fc5685442389e426a6141ef4b1f1f93545a28bb7e51b7b8791a8870e9ab4951e37f99c444b335360b7ff5ed"} 03:52:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:04 INFO - Copying logs to upload dir... 03:52:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.970050 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-20 03:52:04.005108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 03:52:04.009122) ========= 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=6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67773e5a46da448546d977d991055400b7c9171cec248d97a81247b20cc66c95131eb1779815435dad4aa394e98183ce20a1bb15315c759361cc1dfb4a755a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b258e053fee256e80d9b82991795c34d72459b24fc5685442389e426a6141ef4b1f1f93545a28bb7e51b7b8791a8870e9ab4951e37f99c444b335360b7ff5ed"} build_url:https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/E7sOZGZtQHODofjG_MM4Bw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67773e5a46da448546d977d991055400b7c9171cec248d97a81247b20cc66c95131eb1779815435dad4aa394e98183ce20a1bb15315c759361cc1dfb4a755a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b258e053fee256e80d9b82991795c34d72459b24fc5685442389e426a6141ef4b1f1f93545a28bb7e51b7b8791a8870e9ab4951e37f99c444b335360b7ff5ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 03:52:04.036987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:52:04.037457) ========= 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=6dbc10da6d83fee962c624be000001a8-1463740297.979108-1504433153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 03:52:04.124087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 03:52:04.124652) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 03:52:04.125148) ========= ========= Total master_lag: 0.18 =========