builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1461084419.59 results: success (0) buildid: 20160419070133 builduid: e217f5a389b54252b2ef69a4afaa12bb revision: a6a267e0ce6c08f7af8393d522b92c2a2a4ba14e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.586519) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.587030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.587336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.603393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.603697) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 09:46:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-04-19 09:46:59 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.691303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.691627) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:46:59.741028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 09:46:59.741419) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6a267e0ce6c08f7af8393d522b92c2a2a4ba14e --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 a6a267e0ce6c08f7af8393d522b92c2a2a4ba14e --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=337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 09:46:59,956 truncating revision to first 12 chars 2016-04-19 09:46:59,957 Setting DEBUG logging. 2016-04-19 09:46:59,957 attempt 1/10 2016-04-19 09:46:59,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6a267e0ce6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 09:47:00,670 unpacking tar archive at: mozilla-aurora-a6a267e0ce6c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.022342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 09:47:00.776918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 09:47:00.777265) ========= script_repo_revision: a6a267e0ce6c08f7af8393d522b92c2a2a4ba14e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 09:47:00.777676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 09:47:00.777962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 09:47:00.785705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-19 09:47:00.785994) ========= /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=337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:47:01 INFO - MultiFileLogger online at 20160419 09:47:01 in /builds/slave/test 09:47:01 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 09:47:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:01 INFO - {'append_to_log': False, 09:47:01 INFO - 'base_work_dir': '/builds/slave/test', 09:47:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:47:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:01 INFO - 'branch': 'Mozilla-Aurora', 09:47:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:01 INFO - 'config_files': ('talos/linux_config.py',), 09:47:01 INFO - 'default_actions': ('clobber', 09:47:01 INFO - 'read-buildbot-config', 09:47:01 INFO - 'download-and-extract', 09:47:01 INFO - 'populate-webroot', 09:47:01 INFO - 'create-virtualenv', 09:47:01 INFO - 'install', 09:47:01 INFO - 'run-tests'), 09:47:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:01 INFO - 'download_minidump_stackwalk': True, 09:47:01 INFO - 'download_symbols': 'ondemand', 09:47:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:01 INFO - 'installer_path': 'installer.exe', 09:47:01 INFO - 'log_level': 'info', 09:47:01 INFO - 'log_name': 'talos', 09:47:01 INFO - 'log_to_console': True, 09:47:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:47:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:47:01 INFO - 'opt_config_files': (), 09:47:01 INFO - 'pip_index': False, 09:47:01 INFO - 'sps_profile': False, 09:47:01 INFO - 'sps_profile_interval': 0, 09:47:01 INFO - 'suite': 'dromaeojs', 09:47:01 INFO - 'system_bits': '32', 09:47:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:01 INFO - 'title': 'talos-linux64-ix-060', 09:47:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:01 INFO - 'use_talos_json': True, 09:47:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:01 INFO - 'work_dir': 'build'} 09:47:01 INFO - ##### 09:47:01 INFO - ##### Running clobber step. 09:47:01 INFO - ##### 09:47:01 INFO - Running pre-action listener: _resource_record_pre_action 09:47:01 INFO - Running main action method: clobber 09:47:01 INFO - rmtree: /builds/slave/test/build 09:47:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:01 INFO - Running post-action listener: _resource_record_post_action 09:47:01 INFO - ##### 09:47:01 INFO - ##### Running read-buildbot-config step. 09:47:01 INFO - ##### 09:47:01 INFO - Running pre-action listener: _resource_record_pre_action 09:47:01 INFO - Running main action method: read_buildbot_config 09:47:01 INFO - Using buildbot properties: 09:47:01 INFO - { 09:47:01 INFO - "project": "", 09:47:01 INFO - "product": "firefox", 09:47:01 INFO - "script_repo_revision": "production", 09:47:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:47:01 INFO - "repository": "", 09:47:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:47:01 INFO - "buildid": "20160419070133", 09:47:01 INFO - "pgo_build": "True", 09:47:01 INFO - "basedir": "/builds/slave/test", 09:47:01 INFO - "buildnumber": 174, 09:47:01 INFO - "slavename": "talos-linux64-ix-060", 09:47:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:47:01 INFO - "platform": "ubuntu64_hw", 09:47:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:47:01 INFO - "branch": "mozilla-aurora", 09:47:01 INFO - "repo_path": "releases/mozilla-aurora", 09:47:01 INFO - "revision": "a6a267e0ce6c08f7af8393d522b92c2a2a4ba14e", 09:47:01 INFO - "stage_platform": "linux64-pgo", 09:47:01 INFO - "builduid": "e217f5a389b54252b2ef69a4afaa12bb", 09:47:01 INFO - "slavebuilddir": "test" 09:47:01 INFO - } 09:47:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:47:01 INFO - Running post-action listener: _resource_record_post_action 09:47:01 INFO - ##### 09:47:01 INFO - ##### Running download-and-extract step. 09:47:01 INFO - ##### 09:47:01 INFO - Running pre-action listener: _resource_record_pre_action 09:47:01 INFO - Running main action method: download_and_extract 09:47:01 INFO - mkdir: /builds/slave/test/build/tests 09:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:01 INFO - https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:47:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:47:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:47:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:47:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:47:02 INFO - Downloaded 1448 bytes. 09:47:02 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:47:02 INFO - Using the following test package requirements: 09:47:02 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:47:02 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:47:02 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:47:02 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'jsshell-linux-x86_64.zip'], 09:47:02 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:47:02 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:47:02 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:47:02 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:47:02 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:47:02 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:47:02 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:47:02 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:02 INFO - https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:47:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:47:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:47:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:47:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:47:03 INFO - Downloaded 23353420 bytes. 09:47:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:47:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:47:04 INFO - Return code: 0 09:47:04 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:04 INFO - https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:47:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:47:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:47:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:47:06 INFO - Downloaded 23353420 bytes. 09:47:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:47:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:47:08 INFO - Return code: 0 09:47:08 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')]} 09:47:08 INFO - https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:47:09 INFO - Downloaded 10845168 bytes. 09:47:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:47:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:47:09 INFO - Return code: 0 09:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:09 INFO - https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:47:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:47:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:47:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:47:10 INFO - Downloaded 60600545 bytes. 09:47:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:47:10 INFO - mkdir: /builds/slave/test/properties 09:47:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:47:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:47:10 INFO - Contents: 09:47:10 INFO - build_url:https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:47:11 INFO - Running post-action listener: _resource_record_post_action 09:47:11 INFO - Running post-action listener: set_extra_try_arguments 09:47:11 INFO - ##### 09:47:11 INFO - ##### Running populate-webroot step. 09:47:11 INFO - ##### 09:47:11 INFO - Running pre-action listener: _resource_record_pre_action 09:47:11 INFO - Running main action method: populate_webroot 09:47:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:47:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:47:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:47:11 INFO - '--tppagecycles', 09:47:11 INFO - '7'], 09:47:11 INFO - 'tests': ['tsvgm']}}, 09:47:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:47:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:47:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:47:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:47:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'tests': ['damp', 'tps']}, 09:47:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['damp', 'tps']}, 09:47:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:47:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:47:11 INFO - 'other': {'tests': ['a11yr', 09:47:11 INFO - 'ts_paint', 09:47:11 INFO - 'tpaint', 09:47:11 INFO - 'sessionrestore', 09:47:11 INFO - 'sessionrestore_no_auto_restore', 09:47:11 INFO - 'tabpaint']}, 09:47:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['a11yr', 09:47:11 INFO - 'ts_paint', 09:47:11 INFO - 'tpaint', 09:47:11 INFO - 'sessionrestore', 09:47:11 INFO - 'sessionrestore_no_auto_restore', 09:47:11 INFO - 'tabpaint']}, 09:47:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['a11yr', 09:47:11 INFO - 'ts_paint', 09:47:11 INFO - 'tpaint', 09:47:11 INFO - 'sessionrestore', 09:47:11 INFO - 'sessionrestore_no_auto_restore', 09:47:11 INFO - 'tabpaint']}, 09:47:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['a11yr', 09:47:11 INFO - 'ts_paint', 09:47:11 INFO - 'tpaint', 09:47:11 INFO - 'sessionrestore', 09:47:11 INFO - 'sessionrestore_no_auto_restore', 09:47:11 INFO - 'tabpaint']}, 09:47:11 INFO - 'other_l64': {'tests': ['a11yr', 09:47:11 INFO - 'ts_paint', 09:47:11 INFO - 'tpaint', 09:47:11 INFO - 'sessionrestore', 09:47:11 INFO - 'sessionrestore_no_auto_restore', 09:47:11 INFO - 'tabpaint']}, 09:47:11 INFO - 'other_nol64': {'tests': ['a11yr', 09:47:11 INFO - 'ts_paint', 09:47:11 INFO - 'tpaint', 09:47:11 INFO - 'sessionrestore', 09:47:11 INFO - 'sessionrestore_no_auto_restore', 09:47:11 INFO - 'tabpaint']}, 09:47:11 INFO - 'svgr': {'tests': ['tsvgx', 09:47:11 INFO - 'tsvgr_opacity', 09:47:11 INFO - 'tart', 09:47:11 INFO - 'tscrollx', 09:47:11 INFO - 'cart']}, 09:47:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['tsvgx', 09:47:11 INFO - 'tsvgr_opacity', 09:47:11 INFO - 'tart', 09:47:11 INFO - 'tscrollx', 09:47:11 INFO - 'cart']}, 09:47:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'tests': ['tp5o']}, 09:47:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'talos_options': ['--e10s'], 09:47:11 INFO - 'tests': ['tp5o']}, 09:47:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'talos_options': ['--xperf_path', 09:47:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:11 INFO - 'tests': ['tp5n']}, 09:47:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:11 INFO - 'talos_options': ['--e10s', 09:47:11 INFO - '--xperf_path', 09:47:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:11 INFO - 'tests': ['tp5n']}}, 09:47:11 INFO - 'talos.zip': {'path': '', 09:47:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:47:11 INFO - Running post-action listener: _resource_record_post_action 09:47:11 INFO - ##### 09:47:11 INFO - ##### Running create-virtualenv step. 09:47:11 INFO - ##### 09:47:11 INFO - Running pre-action listener: _resource_record_pre_action 09:47:11 INFO - Running main action method: create_virtualenv 09:47:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:47:11 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 09:47:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:47:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:47:11 INFO - Using real prefix '/usr' 09:47:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:47:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:47:14 INFO - Installing pip.................done. 09:47:14 INFO - Return code: 0 09:47:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:14 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:14 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 09:47:14 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 09:47:14 INFO - Using env: {'DISPLAY': ':0', 09:47:14 INFO - 'HOME': '/home/cltbld', 09:47:14 INFO - 'LANG': 'en_US.UTF-8', 09:47:14 INFO - 'LANGUAGE': 'en_US:en', 09:47:14 INFO - 'LOGNAME': 'cltbld', 09:47:14 INFO - 'MAIL': '/var/mail/cltbld', 09:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:14 INFO - 'MOZ_NO_REMOTE': '1', 09:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:14 INFO - 'NO_EM_RESTART': '1', 09:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:14 INFO - 'PWD': '/builds/slave/test', 09:47:14 INFO - 'SHELL': '/bin/bash', 09:47:14 INFO - 'SHLVL': '1', 09:47:14 INFO - 'TERM': 'linux', 09:47:14 INFO - 'TMOUT': '86400', 09:47:14 INFO - 'USER': 'cltbld', 09:47:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:14 INFO - '_': '/tools/buildbot/bin/python'} 09:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:14 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 09:47:14 INFO - Cleaning up... 09:47:14 INFO - Return code: 0 09:47:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:14 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:14 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 09:47:14 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 09:47:14 INFO - Using env: {'DISPLAY': ':0', 09:47:14 INFO - 'HOME': '/home/cltbld', 09:47:14 INFO - 'LANG': 'en_US.UTF-8', 09:47:14 INFO - 'LANGUAGE': 'en_US:en', 09:47:14 INFO - 'LOGNAME': 'cltbld', 09:47:14 INFO - 'MAIL': '/var/mail/cltbld', 09:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:14 INFO - 'MOZ_NO_REMOTE': '1', 09:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:14 INFO - 'NO_EM_RESTART': '1', 09:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:14 INFO - 'PWD': '/builds/slave/test', 09:47:14 INFO - 'SHELL': '/bin/bash', 09:47:14 INFO - 'SHLVL': '1', 09:47:14 INFO - 'TERM': 'linux', 09:47:14 INFO - 'TMOUT': '86400', 09:47:14 INFO - 'USER': 'cltbld', 09:47:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:14 INFO - '_': '/tools/buildbot/bin/python'} 09:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:14 INFO - Downloading/unpacking psutil>=0.7.1 09:47:14 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 09:47:14 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 09:47:14 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 09:47:14 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 09:47:14 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 09:47:14 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 09:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:16 INFO - Installing collected packages: psutil 09:47:16 INFO - Running setup.py install for psutil 09:47:16 INFO - building 'psutil._psutil_linux' extension 09:47:16 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 09:47:16 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 09:47:16 INFO - building 'psutil._psutil_posix' extension 09:47:16 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 09:47:16 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 09:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:17 INFO - Successfully installed psutil 09:47:17 INFO - Cleaning up... 09:47:17 INFO - Return code: 0 09:47:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:47:17 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')]} 09:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:17 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')]} 09:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:17 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:17 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 09:47:17 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 09:47:17 INFO - Using env: {'DISPLAY': ':0', 09:47:17 INFO - 'HOME': '/home/cltbld', 09:47:17 INFO - 'LANG': 'en_US.UTF-8', 09:47:17 INFO - 'LANGUAGE': 'en_US:en', 09:47:17 INFO - 'LOGNAME': 'cltbld', 09:47:17 INFO - 'MAIL': '/var/mail/cltbld', 09:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:17 INFO - 'MOZ_NO_REMOTE': '1', 09:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:17 INFO - 'NO_EM_RESTART': '1', 09:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:17 INFO - 'PWD': '/builds/slave/test', 09:47:17 INFO - 'SHELL': '/bin/bash', 09:47:17 INFO - 'SHLVL': '1', 09:47:17 INFO - 'TERM': 'linux', 09:47:17 INFO - 'TMOUT': '86400', 09:47:17 INFO - 'USER': 'cltbld', 09:47:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:17 INFO - '_': '/tools/buildbot/bin/python'} 09:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:47:19 INFO - Installing collected packages: mozsystemmonitor 09:47:19 INFO - Running setup.py install for mozsystemmonitor 09:47:19 INFO - Successfully installed mozsystemmonitor 09:47:19 INFO - Cleaning up... 09:47:19 INFO - Return code: 0 09:47:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:47:19 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')]} 09:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:19 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')]} 09:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:19 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:19 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 09:47:19 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 09:47:19 INFO - Using env: {'DISPLAY': ':0', 09:47:19 INFO - 'HOME': '/home/cltbld', 09:47:19 INFO - 'LANG': 'en_US.UTF-8', 09:47:19 INFO - 'LANGUAGE': 'en_US:en', 09:47:19 INFO - 'LOGNAME': 'cltbld', 09:47:19 INFO - 'MAIL': '/var/mail/cltbld', 09:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:19 INFO - 'MOZ_NO_REMOTE': '1', 09:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:19 INFO - 'NO_EM_RESTART': '1', 09:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:19 INFO - 'PWD': '/builds/slave/test', 09:47:19 INFO - 'SHELL': '/bin/bash', 09:47:19 INFO - 'SHLVL': '1', 09:47:19 INFO - 'TERM': 'linux', 09:47:19 INFO - 'TMOUT': '86400', 09:47:19 INFO - 'USER': 'cltbld', 09:47:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:19 INFO - '_': '/tools/buildbot/bin/python'} 09:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:19 INFO - Downloading/unpacking blobuploader==1.2.4 09:47:19 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 09:47:19 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 09:47:19 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 09:47:19 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 09:47:19 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 09:47:19 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 09:47:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:47:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:47:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:22 INFO - Downloading docopt-0.6.1.tar.gz 09:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:47:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:47:22 INFO - Running setup.py install for blobuploader 09:47:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:47:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:47:22 INFO - Running setup.py install for requests 09:47:22 INFO - Running setup.py install for docopt 09:47:22 INFO - Successfully installed blobuploader requests docopt 09:47:22 INFO - Cleaning up... 09:47:22 INFO - Return code: 0 09:47:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:22 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')]} 09:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:22 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')]} 09:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:22 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:22 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 09:47:22 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 09:47:22 INFO - Using env: {'DISPLAY': ':0', 09:47:22 INFO - 'HOME': '/home/cltbld', 09:47:22 INFO - 'LANG': 'en_US.UTF-8', 09:47:22 INFO - 'LANGUAGE': 'en_US:en', 09:47:22 INFO - 'LOGNAME': 'cltbld', 09:47:22 INFO - 'MAIL': '/var/mail/cltbld', 09:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:22 INFO - 'MOZ_NO_REMOTE': '1', 09:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:22 INFO - 'NO_EM_RESTART': '1', 09:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:22 INFO - 'PWD': '/builds/slave/test', 09:47:22 INFO - 'SHELL': '/bin/bash', 09:47:22 INFO - 'SHLVL': '1', 09:47:22 INFO - 'TERM': 'linux', 09:47:22 INFO - 'TMOUT': '86400', 09:47:22 INFO - 'USER': 'cltbld', 09:47:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:22 INFO - '_': '/tools/buildbot/bin/python'} 09:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:23 INFO - Running setup.py (path:/tmp/pip-3kkqdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:23 INFO - Running setup.py (path:/tmp/pip-YHRgk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:23 INFO - Running setup.py (path:/tmp/pip-2bruMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:23 INFO - Running setup.py (path:/tmp/pip-luwRNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:23 INFO - Running setup.py (path:/tmp/pip-gK9VEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:23 INFO - Running setup.py (path:/tmp/pip-1xPf2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:23 INFO - Running setup.py (path:/tmp/pip-5QDg6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:23 INFO - Running setup.py (path:/tmp/pip-MT714Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:23 INFO - Running setup.py (path:/tmp/pip-DmLk_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:23 INFO - Running setup.py (path:/tmp/pip-w2ltDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:23 INFO - Running setup.py (path:/tmp/pip-MwMLP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:23 INFO - Running setup.py (path:/tmp/pip-UGv7fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:23 INFO - Running setup.py (path:/tmp/pip-rEMdH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:24 INFO - Running setup.py (path:/tmp/pip-TI4XF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:24 INFO - Running setup.py (path:/tmp/pip-W95zVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:24 INFO - Running setup.py (path:/tmp/pip-t8uT7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:24 INFO - Running setup.py (path:/tmp/pip-dTVwzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:47:24 INFO - Running setup.py install for manifestparser 09:47:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:47:24 INFO - Running setup.py install for mozcrash 09:47:24 INFO - Running setup.py install for mozdebug 09:47:24 INFO - Running setup.py install for mozdevice 09:47:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:47:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:47:24 INFO - Running setup.py install for mozfile 09:47:24 INFO - Running setup.py install for mozhttpd 09:47:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:47:24 INFO - Running setup.py install for mozinfo 09:47:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:47:24 INFO - Running setup.py install for mozInstall 09:47:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Running setup.py install for mozleak 09:47:25 INFO - Running setup.py install for mozlog 09:47:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Running setup.py install for moznetwork 09:47:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Running setup.py install for mozprocess 09:47:25 INFO - Running setup.py install for mozprofile 09:47:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Running setup.py install for mozrunner 09:47:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:47:25 INFO - Running setup.py install for mozscreenshot 09:47:25 INFO - Running setup.py install for moztest 09:47:25 INFO - Running setup.py install for mozversion 09:47:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:47:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:47:26 INFO - Cleaning up... 09:47:26 INFO - Return code: 0 09:47:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:26 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')]} 09:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:26 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')]} 09:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:26 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:26 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 09:47:26 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 09:47:26 INFO - Using env: {'DISPLAY': ':0', 09:47:26 INFO - 'HOME': '/home/cltbld', 09:47:26 INFO - 'LANG': 'en_US.UTF-8', 09:47:26 INFO - 'LANGUAGE': 'en_US:en', 09:47:26 INFO - 'LOGNAME': 'cltbld', 09:47:26 INFO - 'MAIL': '/var/mail/cltbld', 09:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:26 INFO - 'MOZ_NO_REMOTE': '1', 09:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:26 INFO - 'NO_EM_RESTART': '1', 09:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:26 INFO - 'PWD': '/builds/slave/test', 09:47:26 INFO - 'SHELL': '/bin/bash', 09:47:26 INFO - 'SHLVL': '1', 09:47:26 INFO - 'TERM': 'linux', 09:47:26 INFO - 'TMOUT': '86400', 09:47:26 INFO - 'USER': 'cltbld', 09:47:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:26 INFO - '_': '/tools/buildbot/bin/python'} 09:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:26 INFO - Running setup.py (path:/tmp/pip-0x4KCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:26 INFO - Running setup.py (path:/tmp/pip-scl0m2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:26 INFO - Running setup.py (path:/tmp/pip-u8QPTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:26 INFO - Running setup.py (path:/tmp/pip-AjJ3t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:26 INFO - Running setup.py (path:/tmp/pip-eHiKnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:26 INFO - Running setup.py (path:/tmp/pip-5SsosL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:26 INFO - Running setup.py (path:/tmp/pip-tRwiwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:26 INFO - Running setup.py (path:/tmp/pip-Xn3AbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:26 INFO - Running setup.py (path:/tmp/pip-KMBWne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:26 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)) 09:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:26 INFO - Running setup.py (path:/tmp/pip-xFV_yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:27 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)) 09:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:27 INFO - Running setup.py (path:/tmp/pip-OtgEE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:27 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)) 09:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:27 INFO - Running setup.py (path:/tmp/pip-16CUaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:27 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)) 09:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:27 INFO - Running setup.py (path:/tmp/pip-M8TXIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:27 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)) 09:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:27 INFO - Running setup.py (path:/tmp/pip-0XoxrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:27 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)) 09:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:27 INFO - Running setup.py (path:/tmp/pip-lSnSwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:27 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)) 09:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:27 INFO - Running setup.py (path:/tmp/pip-l2xB2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:27 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)) 09:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:27 INFO - Running setup.py (path:/tmp/pip-aqMR8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:27 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)) 09:47:27 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)) 09:47:27 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)) 09:47:27 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)) 09:47:27 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)) 09:47:27 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)) 09:47:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:27 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 09:47:27 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 09:47:27 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 09:47:27 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 09:47:27 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 09:47:27 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 09:47:29 INFO - Downloading blessings-1.6.tar.gz 09:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:47:29 INFO - Installing collected packages: blessings 09:47:29 INFO - Running setup.py install for blessings 09:47:29 INFO - Successfully installed blessings 09:47:29 INFO - Cleaning up... 09:47:29 INFO - Return code: 0 09:47:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:47:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:29 INFO - Reading from file tmpfile_stdout 09:47:29 INFO - Current package versions: 09:47:29 INFO - argparse == 1.2.1 09:47:29 INFO - blessings == 1.6 09:47:29 INFO - blobuploader == 1.2.4 09:47:29 INFO - docopt == 0.6.1 09:47:29 INFO - manifestparser == 1.1 09:47:29 INFO - mozInstall == 1.12 09:47:29 INFO - mozcrash == 0.17 09:47:29 INFO - mozdebug == 0.1 09:47:29 INFO - mozdevice == 0.48 09:47:29 INFO - mozfile == 1.2 09:47:29 INFO - mozhttpd == 0.7 09:47:29 INFO - mozinfo == 0.9 09:47:29 INFO - mozleak == 0.1 09:47:29 INFO - mozlog == 3.1 09:47:29 INFO - moznetwork == 0.27 09:47:29 INFO - mozprocess == 0.22 09:47:29 INFO - mozprofile == 0.28 09:47:29 INFO - mozrunner == 6.11 09:47:29 INFO - mozscreenshot == 0.1 09:47:29 INFO - mozsystemmonitor == 0.0 09:47:29 INFO - moztest == 0.7 09:47:29 INFO - mozversion == 1.4 09:47:29 INFO - psutil == 3.1.1 09:47:29 INFO - requests == 1.2.3 09:47:29 INFO - wsgiref == 0.1.2 09:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:29 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:29 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 09:47:29 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 09:47:29 INFO - Using env: {'DISPLAY': ':0', 09:47:29 INFO - 'HOME': '/home/cltbld', 09:47:29 INFO - 'LANG': 'en_US.UTF-8', 09:47:29 INFO - 'LANGUAGE': 'en_US:en', 09:47:29 INFO - 'LOGNAME': 'cltbld', 09:47:29 INFO - 'MAIL': '/var/mail/cltbld', 09:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:29 INFO - 'MOZ_NO_REMOTE': '1', 09:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:29 INFO - 'NO_EM_RESTART': '1', 09:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:29 INFO - 'PWD': '/builds/slave/test', 09:47:29 INFO - 'SHELL': '/bin/bash', 09:47:29 INFO - 'SHLVL': '1', 09:47:29 INFO - 'TERM': 'linux', 09:47:29 INFO - 'TMOUT': '86400', 09:47:29 INFO - 'USER': 'cltbld', 09:47:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:29 INFO - '_': '/tools/buildbot/bin/python'} 09:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 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)) 09:47:30 INFO - Cleaning up... 09:47:30 INFO - Return code: 0 09:47:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:30 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:30 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 09:47:30 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 09:47:30 INFO - Using env: {'DISPLAY': ':0', 09:47:30 INFO - 'HOME': '/home/cltbld', 09:47:30 INFO - 'LANG': 'en_US.UTF-8', 09:47:30 INFO - 'LANGUAGE': 'en_US:en', 09:47:30 INFO - 'LOGNAME': 'cltbld', 09:47:30 INFO - 'MAIL': '/var/mail/cltbld', 09:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:30 INFO - 'MOZ_NO_REMOTE': '1', 09:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:30 INFO - 'NO_EM_RESTART': '1', 09:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:30 INFO - 'PWD': '/builds/slave/test', 09:47:30 INFO - 'SHELL': '/bin/bash', 09:47:30 INFO - 'SHLVL': '1', 09:47:30 INFO - 'TERM': 'linux', 09:47:30 INFO - 'TMOUT': '86400', 09:47:30 INFO - 'USER': 'cltbld', 09:47:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:30 INFO - '_': '/tools/buildbot/bin/python'} 09:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:30 INFO - Downloading/unpacking jsonschema 09:47:30 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 09:47:30 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 09:47:30 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 09:47:30 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 09:47:30 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 09:47:30 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 09:47:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:47:32 INFO - Downloading/unpacking functools32 (from jsonschema) 09:47:32 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 09:47:32 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 09:47:32 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 09:47:32 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 09:47:32 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 09:47:32 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 09:47:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:47:32 INFO - warning: no files found matching '*.txt' 09:47:32 INFO - no previously-included directories found matching 'build' 09:47:32 INFO - no previously-included directories found matching 'dist' 09:47:32 INFO - no previously-included directories found matching '.git*' 09:47:32 INFO - Installing collected packages: jsonschema, functools32 09:47:32 INFO - Running setup.py install for functools32 09:47:32 INFO - warning: no files found matching '*.txt' 09:47:32 INFO - no previously-included directories found matching 'build' 09:47:32 INFO - no previously-included directories found matching 'dist' 09:47:32 INFO - no previously-included directories found matching '.git*' 09:47:32 INFO - Successfully installed jsonschema functools32 09:47:32 INFO - Cleaning up... 09:47:32 INFO - Return code: 0 09:47:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:47:32 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')]} 09:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:32 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')]} 09:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:32 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 0x7ffc762e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2468410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', '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 09:47:32 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 09:47:32 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 09:47:32 INFO - Using env: {'DISPLAY': ':0', 09:47:32 INFO - 'HOME': '/home/cltbld', 09:47:32 INFO - 'LANG': 'en_US.UTF-8', 09:47:32 INFO - 'LANGUAGE': 'en_US:en', 09:47:32 INFO - 'LOGNAME': 'cltbld', 09:47:32 INFO - 'MAIL': '/var/mail/cltbld', 09:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:32 INFO - 'MOZ_NO_REMOTE': '1', 09:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:32 INFO - 'NO_EM_RESTART': '1', 09:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:32 INFO - 'PWD': '/builds/slave/test', 09:47:32 INFO - 'SHELL': '/bin/bash', 09:47:32 INFO - 'SHLVL': '1', 09:47:32 INFO - 'TERM': 'linux', 09:47:32 INFO - 'TMOUT': '86400', 09:47:32 INFO - 'USER': 'cltbld', 09:47:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:32 INFO - '_': '/tools/buildbot/bin/python'} 09:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:32 INFO - Downloading/unpacking flake8 09:47:32 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 09:47:32 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 09:47:32 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 09:47:32 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 09:47:32 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 09:47:32 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 09:47:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:47:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:47:34 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 09:47:34 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 09:47:34 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 09:47:34 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 09:47:34 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 09:47:34 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 09:47:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:47:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:47:34 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 09:47:34 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 09:47:34 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 09:47:34 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 09:47:34 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 09:47:34 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 09:47:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:47:35 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 09:47:35 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 09:47:35 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 09:47:35 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 09:47:35 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 09:47:35 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 09:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:47:35 INFO - no previously-included directories found matching 'docs/_build' 09:47:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:47:35 INFO - Running setup.py install for pep8 09:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:47:35 INFO - no previously-included directories found matching 'docs/_build' 09:47:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:47:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:47:35 INFO - Cleaning up... 09:47:35 INFO - Return code: 0 09:47:35 INFO - Running post-action listener: _resource_record_post_action 09:47:35 INFO - Running post-action listener: _start_resource_monitoring 09:47:35 INFO - Starting resource monitoring. 09:47:35 INFO - ##### 09:47:35 INFO - ##### Running install step. 09:47:35 INFO - ##### 09:47:35 INFO - Running pre-action listener: _resource_record_pre_action 09:47:35 INFO - Running main action method: install 09:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:35 INFO - Reading from file tmpfile_stdout 09:47:35 INFO - Detecting whether we're running mozinstall >=1.0... 09:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:47:35 INFO - Reading from file tmpfile_stdout 09:47:35 INFO - Output received: 09:47:35 INFO - Usage: mozinstall [options] installer 09:47:35 INFO - Options: 09:47:35 INFO - -h, --help show this help message and exit 09:47:35 INFO - -d DEST, --destination=DEST 09:47:35 INFO - Directory to install application into. [default: 09:47:35 INFO - "/builds/slave/test"] 09:47:35 INFO - --app=APP Application being installed. [default: firefox] 09:47:35 INFO - mkdir: /builds/slave/test/build/application 09:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:47:51 INFO - Reading from file tmpfile_stdout 09:47:51 INFO - Output received: 09:47:51 INFO - /builds/slave/test/build/application/firefox/firefox 09:47:51 INFO - Running post-action listener: _resource_record_post_action 09:47:51 INFO - ##### 09:47:51 INFO - ##### Running run-tests step. 09:47:51 INFO - ##### 09:47:51 INFO - Running pre-action listener: _resource_record_pre_action 09:47:51 INFO - Running main action method: run_tests 09:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:51 INFO - Python 2.7.3 09:47:51 INFO - Return code: 0 09:47:51 INFO - grabbing minidump binary from tooltool 09:47: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')]} 09:47:51 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 0x24f7160>, '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 0x24f8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f84f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:51 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 09:47:51 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 09:47:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:51 INFO - Return code: 0 09:47:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:47:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:47:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:47:52 INFO - Return code: 0 09:47:52 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/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:47:52 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/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 09:47:52 INFO - Using env: {'DISPLAY': ':0', 09:47:52 INFO - 'HOME': '/home/cltbld', 09:47:52 INFO - 'LANG': 'en_US.UTF-8', 09:47:52 INFO - 'LANGUAGE': 'en_US:en', 09:47:52 INFO - 'LOGNAME': 'cltbld', 09:47:52 INFO - 'MAIL': '/var/mail/cltbld', 09:47:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:52 INFO - 'MOZ_NO_REMOTE': '1', 09:47:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:52 INFO - 'NO_EM_RESTART': '1', 09:47:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:52 INFO - 'PWD': '/builds/slave/test', 09:47:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:52 INFO - 'SHELL': '/bin/bash', 09:47:52 INFO - 'SHLVL': '1', 09:47:52 INFO - 'TERM': 'linux', 09:47:52 INFO - 'TMOUT': '86400', 09:47:52 INFO - 'USER': 'cltbld', 09:47:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958', 09:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:52 INFO - '_': '/tools/buildbot/bin/python'} 09:47:52 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/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:47:52 INFO - mozversion application_buildid: 20160419070133 09:47:52 INFO - mozversion application_changeset: a6a267e0ce6c08f7af8393d522b92c2a2a4ba14e 09:47:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:47:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:52 INFO - mozversion application_name: Firefox 09:47:52 INFO - mozversion application_remotingname: firefox-dev 09:47:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:47:52 INFO - mozversion application_vendor: Mozilla 09:47:52 INFO - mozversion application_version: 47.0a2 09:47:52 INFO - mozversion platform_buildid: 20160419070133 09:47:52 INFO - mozversion platform_changeset: a6a267e0ce6c08f7af8393d522b92c2a2a4ba14e 09:47:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:47:52 INFO - mozversion platform_version: 47.0a2 09:47:52 INFO - using testdate: 1461084472 09:47:52 INFO - actual date: 1461084472 09:47:52 INFO - starting webserver on 'localhost:51296' 09:47:52 INFO - SUITE-START | Running 2 tests 09:47:52 INFO - TEST-START | dromaeo_css 09:47:52 INFO - operating with platform_type : linux_ 09:47:52 INFO - Initialising browser for dromaeo_css test... 09:47:52 INFO - TEST-INFO | started process 21425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1LBows/profile http://localhost:51296/getInfo.html) 09:47:56 INFO - PROCESS | 21425 | __metrics Screen width/height:1600/1200 09:47:56 INFO - PROCESS | 21425 | colorDepth:24 09:47:56 INFO - PROCESS | 21425 | Browser inner width/height: 1024/697 09:47:56 INFO - PROCESS | 21425 | __metrics 09:47:57 INFO - PROCESS | 21425 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:58 INFO - TEST-INFO | 21425: exit 0 09:47:58 INFO - Browser initialized. 09:47:58 INFO - Running cycle 1/1 for dromaeo_css test... 09:47:58 INFO - TEST-INFO | started process 21518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1LBows/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:10 INFO - PROCESS | 21518 | RSS: Main: 142450688 09:48:10 INFO - PROCESS | 21518 | 09:49:01 INFO - PROCESS | 21518 | 1461084541684 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] 09:51:09 INFO - PROCESS | 21518 | Cycle 1(1): loaded http://localhost:51296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51296/tests/dromaeo/cssquery-ext.html) 09:51:10 INFO - PROCESS | 21518 | RSS: Main: 253886464 09:51:10 INFO - PROCESS | 21518 | 09:54:12 INFO - PROCESS | 21518 | Cycle 1(1): loaded http://localhost:51296/tests/dromaeo/cssquery-ext.html (next: http://localhost:51296/tests/dromaeo/cssquery-jquery.html) 09:54:13 INFO - PROCESS | 21518 | RSS: Main: 228229120 09:54:13 INFO - PROCESS | 21518 | 09:57:15 INFO - PROCESS | 21518 | Cycle 1(1): loaded http://localhost:51296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51296/tests/dromaeo/cssquery-mootools.html) 09:57:15 INFO - PROCESS | 21518 | RSS: Main: 221720576 09:57:15 INFO - PROCESS | 21518 | 10:00:17 INFO - PROCESS | 21518 | Cycle 1(1): loaded http://localhost:51296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51296/tests/dromaeo/cssquery-prototype.html) 10:00:17 INFO - PROCESS | 21518 | RSS: Main: 212451328 10:00:17 INFO - PROCESS | 21518 | 10:03:20 INFO - PROCESS | 21518 | Cycle 1(1): loaded http://localhost:51296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51296/tests/dromaeo/cssquery-yui.html) 10:03:20 INFO - PROCESS | 21518 | RSS: Main: 214671360 10:03:20 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | Cycle 1(1): loaded http://localhost:51296/tests/dromaeo/cssquery-yui.html (next: http://localhost:51296/tests/dromaeo/cssquery-dojo.html) 10:06:23 INFO - PROCESS | 21518 | RSS: Main: 258363392 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | __start_tp_report 10:06:23 INFO - PROCESS | 21518 | _x_x_mozilla_page_load 10:06:23 INFO - PROCESS | 21518 | _x_x_mozilla_page_load_details 10:06:23 INFO - PROCESS | 21518 | |i|pagename|runs| 10:06:23 INFO - PROCESS | 21518 | |0;dojo.html;3288.7204587610054;3296.9340613187724;3356.8657253709866;3357.5299458075874;3378.898633041009;5353.544948679362;5366.168243922193;5371.301730774999;5386.48828361306;5393;5317.6809391436545;5378.946210537893;5384.3807962084375;5392.4337944515755;5399.9730001349935;4800.783964721596;4882.853514394574;4931.778069986841;4932.210846264607;4963.528464795857;4832;4890.14422476067;4900.485449027854;4938.061768264036;4952.182889823175;4953.182724850395;4955.529224723664;4968.627352948525;4969.527894849984;5011.398632164127;4807.158747219258;4867.464578896319;4914.434839993411;4927.556519913225;4986.326845875797;4842.467328593852;4873.853784386439;4876.731779752112;4886.169351210303;4888.755562221874;5202.4277329493725;5208.348956380452;5240.3187585614005;5241.082810508184;5256.579473642099;5590.888182236373;5749.3388260350175;5765.250517432749;5784.68184249866;5830.271216097988;5765.1928729977835;5769.423057694239;5781.739821708034;5794.88410231793;5795.1017592273265;5406.54044406226;5407.594430417735;5410.026195284847;5410.404855465935;5435.076037073707;5706.9714651426475;5856.912146317809;5881.3530511643685;5916.49709774674;5946.732397042144;5648.802291919763;5650.039493286151;5657.98156331856;5665.830025099253;5687;5703;5747.597668163272;5764.913526297109;5779.33537643168;5786.218860453869;5606.355269144019;5619.831405057855;5639.859003524863;5682.374938756733;5702.800401985911;5698.287714035746;5702.45826646468;5704.4295570443455;5709.68596727184;5730.942690573124;4344.47866256045;4374.081442897027;4405.845795397146;4410.735355878657;4424.7123936944;3964.484616999829;4008.6793056555407;4016.779077150785;4022.4770779799023;4038.959610403917;5465.125579907196;5473.75368108436;5487.42382049887;5488.9725551371985;5499.092649712833;5683.715814209273;5777.162311464814;5785.82642520725;5793.362730099686;5797.188393624896;5494.2582751328055;5494.642848214933;5500.22996780451;5511.090670039479;5519.834404967857;4977.552020318117;4978.651494395358;4993.975030124899;5001.124803159432;5008.048470790538;5818.44724751148;5962.522998160137;5979.9402005980255;6023.6385816851125;6050.364711705296;5704.087346024616;5782.277215348082;5792.94207057924;5812.476877080914;5816.331121920864;5949.52403807703;5963.194968679173;5963.671998039976;5970.283565972111;5983.833152535388;5605.80379686709;5648.926703926241;5718.828435146952;5750.942490575041;5866.560007999503;5816.709164541671;5832.650040997553;5844.94155058444;5850.3857095006115;5865.501432378295;5689.061304884648;5692.260006199168;5709.65742055478;5711.371749107512;5712.343080545625;5584.720763961867;5625.071863142535;5669.291338582677;5683.857903552444;5710.5146062585145;5562.777488900399;5567.805126820542;5576.525995290283;5581.74882130297;5586.832395028156;5664.830055098354;5667.319921609434;5685.118806584986;5699.572532060195;5702.543796496353;5411.188321751769;5439.864003399946;5527.060399731975;5546.694931778791;5590.608657393944 10:06:23 INFO - PROCESS | 21518 | |1;ext.html;554.4344768336297;557.4481263549086;572.044685375423;572.9369769325376;583.3641330949265;39487.21025579487;40463.19073618526;40475.79762101193;40511.392329115086;40545.189096218055;42930.57069429305;43006.35490467645;43106.784466077705;43447.3482897756;43494.56505434945;8828.690995815148;9000.684976025841;9045.954770226139;9048.638054477813;9052.502112383816;8757.693480728176;8923.866142007875;8924.598393072294;9150.359474836763;9152.039035901234;9135.68025119121;9236.12256835603;9236.353455258135;9241.537923103851;9244.953775231115;9001.864972025392;9169.724908252763;9189.218916392114;9190.448573085636;9190.770230744218;9037.277017838556;9148.451092934445;9162.725118246462;9175;9181.908180918172;42453.15093698109;42976.78511607422;43042.56957430417;43110.78444607757;43130;3729.925401491982;3761.9247615047548;3796.2217745362136;3803.315403227418;4294.828206871753;32224.355512889844;32498.67501325004;32780.508292375634;32935.17662058444;33286.6671333286;3717.5724791648768;3778.7543809652284;3813.3707938190164;3819.083419979185;3973;284256;286073;286454;286847;287184.9999999979;60468.69765651144;62049.207785649756;62098.689506553084;62122.37877621166;62180.689096554226;71143.64428177827;71839;71893;71959;71968.28031719616;17489;17596.912015440095;17708.645827083386;17726.645467090842;17726.91136544309;13767.449302027806;13840;13854.16874987504;13867.09863858866;13867.237301948287;21271.680924786142;21276.893615531822;21494.462638434165;21518.892405537874;22577.209797657004;8086.959565202254;8309.37679674027;8311.16888311176;8391.62237699305;8547.017093034256;1016.7356487313203;1063.8297872340388;1077.4828082520435;1117.5250518529756;1124.8818874018275;30829.691703083132;30955.380892382476;31071.68928310733;31160.53259201114;31329.373412532077;1117.5138814615668;1141.6289705845634;1236.5301185549613;1238.746057058301;1283.1082397733485;15892.92053539748;16095;16220.594485137966;16377.344906203618;16417;349523;354002;354204;354225;354956;56416.43583564112;56942;57029.42970570241;57098.714506428034;57131.71434142803;1280.6606249343931;1427.1651084115908;1476.2102275282673;1483.0434369831398;1510.9622259443602;27484.725152749015;27933.720662793923;27958.72041279561;28425.147245582666;28875.855620722603;42478;42803.78598107114;42937;43063.56936430596;43071.35392969171;202351;205605;206641;206672;207113;30400.695993039786;33976.490352645225;34212.31575368429;34296;34405.483917740756;40839.38740918948;41247.175056499305;42199.57800422079;42239;44124.33813492736;37429;37709.81145094257;38017.04957376088;38141.618583813804;38400.2319953605;36432.63567364292;36713.81643091767;37048.81475592605;37061.62938370582;37316.626833731316;35308.11729706778;36483.45274820827;36624.45063324105;36767.63232367642;36995.26009479849;31832.314306541037;32741.836290819345;33131.50302745509;33612.49581256332;33745.662543375234;25535.106271280416;25811.741882581686;25867.482650346512;25890.22329330123;26215.475690486466 10:06:23 INFO - PROCESS | 21518 | |2;jquery.html;366.65168090314194;368.84508506427295;389.4605970730539;391.4734681852907;392.6603487982894;17433;18106.728399074007;19012.61974760506;19466.707999379985;19471.805281947178;17640.911795441036;17746.29014839408;18535.351262705808;18535.814641853576;18547;5656.802011929583;5783.913241301363;5812.331581868076;5822.039363505017;5822.184894114827;4308.482982042159;5751.65490070595;6142.785002524913;6349.42855143037;6411.134496842913;6348.143000694893;6348.523860710442;6357.459615932651;6361.395667411589;6362.204724409449;6222.533310001745;6262.405071518198;6279.120923070774;6399.360063993563;6409.967950160266;3852.364359880616;5418.8916221675345;5612.15817627355;5621.578381621354;5691.345495268056;21099.261525846523;21670.78329216719;21804.563908721735;21832.126714931383;21878.781212187994;2398.9160379386813;2407.9200859759057;2474.39377352548;2525.7600527949817;2529.7976161907004;9976.501174941297;10513.316634418738;13845.584632461043;13947.232902190375;14452.855471445257;1856.6286742651523;1945.5525229197222;1999.7900220476786;2008.1465377214624;2049.733534640487;64517;65245.34754652488;65433.67283163602;66983;67350;10528.631497897537;10535.683929482127;10536.631217907336;10621.787564248672;10794.082502987178;14891;15018.774718379233;15021;15117.924410377878;15146.772798408032;8181.550014749127;8271.586420678943;8328.541930193776;8387.077421483631;8454.28138608213;8050.637721302555;8098.635561399751;8108.8378232435025;8156.306713929383;8308;4715.457722361973;4720.33915251865;4748.525147485293;4781.354517140142;4813.855584332476;1774.643409396358;1820.1263393570896;1901.9619607608047;1910.2263583248807;1916.2143521156258;1026.7381817636456;1038.5067093130704;1045.911097556701;1090.8472813806075;1094.2832444748703;16198.919005404898;16430.8156465881;16648;16723.331066757437;17349.56626084358;982.8673129127619;993.9254555908336;1020.9693709188737;1052.4948024947914;1067.80779459698;9790.363626364264;9961.601535938626;9974.45140517264;10008.348622477355;10052.899471005196;432080;437467;438954;443586;446958;73363.63318183375;74730;74782.62608686922;74983;75021.24978750142;1059.9152067834555;1071.4160782373624;1091.317926296065;1093.3986307530827;1104.8066588347167;15522.689546209238;15609.375624974873;15609.843901561293;15626.952744214768;15764.369425223322;34321.48517772186;34405.31189376248;34725.30549388948;35500.467492988144;35511.93464196078;48261.5173848257;48454.27318590153;48460;48709.51290487192;49387.259191112884;8418.242358187792;8597.398182127192;8683.478991260292;8817.779555511164;8843.425177363451;7671.88401185342;11169.441527923735;13181.868181318448;13309.66725831862;13473.258970756702;10093.394396336244;11412.144089193178;11477.426128693365;11597.478113485082;11919.04647628205;11540.134489913122;11580.247283926517;11583.884161158281;11722.58970936013;11827.40862956866;10471.3193642413;11717.296962182296;12017.459214335551;12078.33569153705;12088.939555302168;8777.51723655205;8814.162654547808;8871.512066836385;8895.243904268209;8991.55042247898;11677.649670509898;11681.649550513499;11718.70703232426;11732.765344692887;11800.76398472043 10:06:23 INFO - PROCESS | 21518 | |3;mootools.html;1305.8955283577316;1596;1609.3643011010652;1881.9811801881976;1986.443795737193;7697.384209263252;7865.410094242933;7871.252231038056;7877.094134174572;7881.842363152734;7832.255935686101;7986.560739159344;7991.600419978992;7999;8008.799780005503;2074.471009892475;2255.639097744357;2280.2817112609473;2296.219285442949;2312.7918487336137;2330.720313562375;2336.1356298169703;2341.274204996448;2352.2943117064897;2367.159658321297;2246.8314876384256;2299.609066458706;2302.804261637763;2304.746477887431;2306.3772781349026;2217.2904670505445;2252.358077947785;2285.462916214688;2286.039863257436;2298.9195378161853;2216.9334919952425;2235.3740952533317;2240.462289050616;2247.1797793805144;2248.6964259824877;8060.153683863168;8120.4315697901175;8126.593670316461;8130.308923741489;8138.470999385021;4876.536729010738;5016.573591244749;5019.021290848286;5021.824236151754;5027.49725027498;3145.496720524705;3148.449021421242;3149.291409432882;3171.413288541627;3212.4217640824877;998.9800203995952;1007.7581380468708;1018.221060888421;1024.8975102489692;1065.9626913058082;11234.943825280903;11242.381669008202;11245;11247.718807029807;11267.887321126847;4238.512571054368;4294.549072347359;4397.34039894012;4397.406350142754;4407.537208593051;9575.952120239353;9593.856092158623;9606.327557070937;9612.903870961201;9615.086566776145;4515.345274935116;5077.035363280965;5097.8215762448135;5101.591872650179;5109.9744501277255;4336.9132617348105;4356.716813407118;4386.035072284092;4411.9558804411545;4423.579759922803;3604.2250916053176;3714.4428335749312;3719.8326075326677;3751.4185301278344;3796.3166630006863;1170.695619139013;1187.7090112922217;1192.7674103549898;1194.4326444938586;1205.6202296276645;1149.5286932357694;1162.8837116288473;1163.3892206591438;1173.5423184957874;1198.2750435986277;7541.585212813348;7579.583122928292;7624.80937976555;7663.770086897291;7671.53970761756;1149.1553708024596;1157.8494795676509;1158.4381574936149;1172.1033409441784;1245.0848626259692;6009.969950150221;6024.57827952048;6059.515238780887;6065.059915713072;6072.39276072398;9282.35023548345;9898.851517227247;9912.900870991341;9916.355436896578;10040.447775372424;9797.902020979698;9832.655857044969;9918.752031199134;9932;9941.204703623693;7499.437542184358;7765.689372425153;7866.410019248579;7881.330086942559;7895.289423951872;7379.631018448948;7441.516301440389;7468.813279668052;7472.252774722484;7476.5514069156025;8656.177663121993;8669;8669.436486628349;8735.825283494167;8958;8759.518226497605;8955.104489550993;9108.22580080674;9117.452952822852;9203.493807840632;6232.127502149612;6412.358764123737;6422.550421470452;6948.6525673715105;7063.611501367474;7130.108736407949;7349.4855360124275;7520.247975202436;7526.736564220226;7533.660985255567;6888.690008949709;7054.435645148274;7061.399781018466;7108.360247577536;7183.676734547063;7075.186353569406;7110.857782844418;7116.679749411393;7211.783646490614;7252.4560657949805;7334.4132469403385;7345.081864766904;7461.403087753075;7483.027206463125;7487.5507469552;6734.3602357775935;6748.6963086660235;6761.492888033516;6770.32296770319;6781.084553585203;6870.106886104774;6930;6943.236244013256;6946.895796563157;6974.407175389946 10:06:23 INFO - PROCESS | 21518 | |4;prototype.html;356.8305055098828;362.1670158635138;364.5206553382302;366.32961680125374;367.79954924566107;6071.666058366788;6101.969490152548;6113.51091912647;6126.540509461786;6139.140520327158;6011.098335249715;6075;6089.817305480843;6095.055266433699;6105.358937311585;4470.7317560946285;4557.908841823161;4641.582257596816;4747.715137091785;4753.0969115867965;4709.45841228258;4732.526747325274;4736.100140973204;4750.928736068961;4753.62144977956;4703.318018887259;4709.5290470952805;4712.269598212282;4718.528147185289;4723.338732577442;4496.033352829141;4570.3829982952375;4642.419697537808;4650.720956742606;4657.39453870998;4159.292920203573;4174.478190226222;4179.728317659343;4189.371594260855;4194.30793919003;5700.230468886689;5710.14347847822;5710.800121995751;5710.885782284373;5721.828345149652;5478.698671573062;5482.671039737628;5486.177073438977;5486.3690675572425;5488.396276409591;6357.65032923189;6373.808785736435;6377.553571250014;6379.681015949231;6379.87240255197;4379.080393117417;4552.294394368878;4556.270996640522;4562.475315338712;4652.488226295105;6606.438452731523;6634.104395906539;6667.633280169589;6668.466522678174;6674.399304062657;4655;4659.5573420525;4660.976695116503;4663.813447462131;4669.836555720533;4703.341532185428;4728.834490792875;4732.124556956974;4732.455767586772;4740.762961851894;5409.972950135303;5410.404855465896;5410.864728381744;5412.134058550613;5423.945760542423;6292.402221788922;6411.230652321751;6420.935790642127;6435.710393032231;6437.581557198767;1645.7942757155356;1661.7756602858701;1667.6998140334856;1670.5322509697305;1671.4818406294087;1041.7135287795916;1066.594694016269;1070.1331921143742;1094.7427354571669;1119.3339962722168;6044.093385992136;6131.84670383244;6292.874142517124;6354.555181137369;6368.872622547616;6682.231543372477;6687.531872768859;6692.330766923366;6701.631410272482;6702.530822842355;6334.746610135635;6335.208098987627;6338.683065846689;6347.333529979285;6355.396237357444;3552.0764601203873;3562.6437356264164;3599.046252743025;3601.621829707843;3602.8919132426067;6794.8641027180165;6895.827604309832;6948.5483443576;6951.826204344932;6957.686904089328;6822.9317706823285;6833.794986150423;6840.965795170992;6842.144731908512;6845.863082738417;6916.3429474200875;6929.064576282238;6932.306769323128;6933.618650974144;6939.479539034492;6630.90053649186;6654.667266636746;6669.366410191024;6681.365270299314;6682;6409.935900640934;6541.476681865534;6557.9342507110105;6558.934410656023;6567.2447668518735;6890.44876409896;6912.066870972354;6916.792496225121;6918.619475928872;6931.341522555349;4588.426446694163;4594.7702614869795;4600.539946005372;4603.838865639686;4605.148047611203;6654.13496245485;6654.567453115532;6658;6661.666916654245;6675.165604299463;6345.746170153327;6484.416402523795;6486.254080780771;6487.54587178893;6490.8052758417325;6402.263739669997;6449.838754031187;6469.902951455826;6484.1246431733;6484.5460817742305;6339.809805705836;6348.143000694847;6350.460210882126;6357.554971151975;6403.327650596807;6471.126397936407;6515.771947981798;6516.315786842313;6522.934770652233;6523.967380163069;6070.48400885912;6184.536159788124;6200.286966998853;6359.777407790705;6359.8092057238355 10:06:23 INFO - PROCESS | 21518 | |5;yui.html;764.9082110146783;774.0633833061995;806.3911746631294;866.2896424931556;888.293806423893;16620.833791662095;16945;16956.576085597866;16973.2362043708;16975.15124243789;15600.921995390006;15751.60620984476;15755.291011904463;15763;15783.447579334726;792.0218530115303;922.6032805893464;924.6116631014974;932.2774849491631;934.0472717827812;948.1466679987997;952.7713348796274;952.8094381123768;958.712386284112;960.2749923807515;832.2010869565224;977.8191034658576;987.7678745494803;989;989.2382865193797;828.2959484438239;974.926880483963;990.5542505872351;993.5330394714473;994.2642444591023;725.7786375155575;726.4188649080714;726.5459088069956;733.8055415314946;735.3896266099179;14975.850241497554;15009.849901500955;15162.469313573973;15266.465673701477;15281.847181528154;13342.533011344653;13360.532381366702;13461;13639.795403068962;14152.221627810466;11415.42922853854;11558.133140014532;11592.826107608393;11614.535418583246;11749.588764393206;3750.79370634615;3771.9245615087543;3812.370958791796;3867.3232184367903;3870.3033453978555;53074.73462632701;53155;53624;53658;53938.460615393735;9918.702438926699;10053;10104.797904042025;10119.898801011896;10218.437985910698;18007.819921800616;18022;18034.188461519265;18037.368692095715;18069.909650451664;6901.930980690229;7461.664225109775;8011.1588283230585;8309.709160179365;8354.540500272422;4680.368150299666;4702.318163866289;4724.267738500538;4725.432948046257;4800.159972004885;3454.378211921878;3464.6535346465657;3469.4795780632603;3471.9826400868337;3473.774204676688;643.3116565275204;650.9707063182168;653.2748648999607;661.0976017735757;666.9833254168684;633.4235845380681;690.7547820523641;728.6502478810095;739.6043116932416;760.6044856674608;8700.303975682056;8714.825703485894;8771.912280877237;8774.078721734253;8832.55837208137;667.7262322447773;748.1097493982144;757.9924200758032;770.7995921060565;781.4920301803872;4249.532551419341;4259.829606815754;4316.1583491219535;4403.471583409947;4461.598456138963;61758;62470.37529624646;62779;63423.68288158529;63471.36528634747;55486;55706.72146639322;56773;57565.424345756845;57713.71143144257;50393.74803125961;50803;52059.479405205464;52619.473805261456;53040.73479632577;8601.311895048506;8711.564421779012;8751.431156974777;8818.470891746516;8861.424007439497;39527.60472395239;39785.2042959145;40296.194076118896;40740;40889.1822163561;48360.75819620879;50145.24782128198;50337.74831125821;50568.49431505785;51864;10982.450877456255;11277.548898043986;11357;11478.426078695864;11519.712007199887;12442.626721198378;12464.688382790502;12717.745645087232;12805.167664101804;13330.26683532415;11103.722406939569;11209.719757005814;11362.261453005529;11409.429528523706;11451.216042882143;11837.112216583619;12178.512859485876;12289.07831912628;12361.887430131332;12552.623421297376;11615.6515304541;11721.941390292994;11787.233829801036;11975.041996640073;11991.820122697993;10172.949135254275;10377.636782712569;10420.270581059252;10453.843192352273;10755.408452535186;9941.30410871232;10083.596656133672;10159.085682288629;10173.643922462677;10228.386296822215 10:06:23 INFO - PROCESS | 21518 | __end_tp_report 10:06:23 INFO - PROCESS | 21518 | __start_cc_report 10:06:23 INFO - PROCESS | 21518 | _x_x_mozilla_cycle_collect,907 10:06:23 INFO - PROCESS | 21518 | __end_cc_report 10:06:23 INFO - PROCESS | 21518 | __startTimestamp1461085583552__endTimestamp 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | ------- Summary: start ------- 10:06:23 INFO - PROCESS | 21518 | Number of tests: 6 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | [#0] dojo.html Cycles:165 Average:5363.23 Median:5581.75 stddev:578.26 (10.4%) stddev-sans-first:556.66 10:06:23 INFO - PROCESS | 21518 | Values: 3288.7 3296.9 3356.9 3357.5 3378.9 5353.5 5366.2 5371.3 5386.5 5393.0 5317.7 5378.9 5384.4 5392.4 5400.0 4800.8 4882.9 4931.8 4932.2 4963.5 4832.0 4890.1 4900.5 4938.1 4952.2 4953.2 4955.5 4968.6 4969.5 5011.4 4807.2 4867.5 4914.4 4927.6 4986.3 4842.5 4873.9 4876.7 4886.2 4888.8 5202.4 5208.3 5240.3 5241.1 5256.6 5590.9 5749.3 5765.3 5784.7 5830.3 5765.2 5769.4 5781.7 5794.9 5795.1 5406.5 5407.6 5410.0 5410.4 5435.1 5707.0 5856.9 5881.4 5916.5 5946.7 5648.8 5650.0 5658.0 5665.8 5687.0 5703.0 5747.6 5764.9 5779.3 5786.2 5606.4 5619.8 5639.9 5682.4 5702.8 5698.3 5702.5 5704.4 5709.7 5730.9 4344.5 4374.1 4405.8 4410.7 4424.7 3964.5 4008.7 4016.8 4022.5 4039.0 5465.1 5473.8 5487.4 5489.0 5499.1 5683.7 5777.2 5785.8 5793.4 5797.2 5494.3 5494.6 5500.2 5511.1 5519.8 4977.6 4978.7 4994.0 5001.1 5008.0 5818.4 5962.5 5979.9 6023.6 6050.4 5704.1 5782.3 5792.9 5812.5 5816.3 5949.5 5963.2 5963.7 5970.3 5983.8 5605.8 5648.9 5718.8 5750.9 5866.6 5816.7 5832.7 5844.9 5850.4 5865.5 5689.1 5692.3 5709.7 5711.4 5712.3 5584.7 5625.1 5669.3 5683.9 5710.5 5562.8 5567.8 5576.5 5581.7 5586.8 5664.8 5667.3 5685.1 5699.6 5702.5 5411.2 5439.9 5527.1 5546.7 5590.6 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | [#1] ext.html Cycles:180 Average:46606.06 Median:20523.28 stddev:75418.89 (367.5%) stddev-sans-first:75551.19 10:06:23 INFO - PROCESS | 21518 | Values: 554.4 557.4 572.0 572.9 583.4 39487.2 40463.2 40475.8 40511.4 40545.2 42930.6 43006.4 43106.8 43447.3 43494.6 8828.7 9000.7 9046.0 9048.6 9052.5 8757.7 8923.9 8924.6 9150.4 9152.0 9135.7 9236.1 9236.4 9241.5 9245.0 9001.9 9169.7 9189.2 9190.4 9190.8 9037.3 9148.5 9162.7 9175.0 9181.9 42453.2 42976.8 43042.6 43110.8 43130.0 3729.9 3761.9 3796.2 3803.3 4294.8 32224.4 32498.7 32780.5 32935.2 33286.7 3717.6 3778.8 3813.4 3819.1 3973.0 284256.0 286073.0 286454.0 286847.0 287185.0 60468.7 62049.2 62098.7 62122.4 62180.7 71143.6 71839.0 71893.0 71959.0 71968.3 17489.0 17596.9 17708.6 17726.6 17726.9 13767.4 13840.0 13854.2 13867.1 13867.2 21271.7 21276.9 21494.5 21518.9 22577.2 8087.0 8309.4 8311.2 8391.6 8547.0 1016.7 1063.8 1077.5 1117.5 1124.9 30829.7 30955.4 31071.7 31160.5 31329.4 1117.5 1141.6 1236.5 1238.7 1283.1 15892.9 16095.0 16220.6 16377.3 16417.0 349523.0 354002.0 354204.0 354225.0 354956.0 56416.4 56942.0 57029.4 57098.7 57131.7 1280.7 1427.2 1476.2 1483.0 1511.0 27484.7 27933.7 27958.7 28425.1 28875.9 42478.0 42803.8 42937.0 43063.6 43071.4 202351.0 205605.0 206641.0 206672.0 207113.0 30400.7 33976.5 34212.3 34296.0 34405.5 40839.4 41247.2 42199.6 42239.0 44124.3 37429.0 37709.8 38017.0 38141.6 38400.2 36432.6 36713.8 37048.8 37061.6 37316.6 35308.1 36483.5 36624.5 36767.6 36995.3 31832.3 32741.8 33131.5 33612.5 33745.7 25535.1 25811.7 25867.5 25890.2 26215.5 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | [#2] jquery.html Cycles:180 Average:26084.69 Median:2500.08 stddev:72063.22 (2882.4%) stddev-sans-first:72239.51 10:06:23 INFO - PROCESS | 21518 | Values: 366.7 368.8 389.5 391.5 392.7 17433.0 18106.7 19012.6 19466.7 19471.8 17640.9 17746.3 18535.4 18535.8 18547.0 5656.8 5783.9 5812.3 5822.0 5822.2 4308.5 5751.7 6142.8 6349.4 6411.1 6348.1 6348.5 6357.5 6361.4 6362.2 6222.5 6262.4 6279.1 6399.4 6410.0 3852.4 5418.9 5612.2 5621.6 5691.3 21099.3 21670.8 21804.6 21832.1 21878.8 2398.9 2407.9 2474.4 2525.8 2529.8 9976.5 10513.3 13845.6 13947.2 14452.9 1856.6 1945.6 1999.8 2008.1 2049.7 64517.0 65245.3 65433.7 66983.0 67350.0 10528.6 10535.7 10536.6 10621.8 10794.1 14891.0 15018.8 15021.0 15117.9 15146.8 8181.6 8271.6 8328.5 8387.1 8454.3 8050.6 8098.6 8108.8 8156.3 8308.0 4715.5 4720.3 4748.5 4781.4 4813.9 1774.6 1820.1 1902.0 1910.2 1916.2 1026.7 1038.5 1045.9 1090.8 1094.3 16198.9 16430.8 16648.0 16723.3 17349.6 982.9 993.9 1021.0 1052.5 1067.8 9790.4 9961.6 9974.5 10008.3 10052.9 432080.0 437467.0 438954.0 443586.0 446958.0 73363.6 74730.0 74782.6 74983.0 75021.2 1059.9 1071.4 1091.3 1093.4 1104.8 15522.7 15609.4 15609.8 15627.0 15764.4 34321.5 34405.3 34725.3 35500.5 35511.9 48261.5 48454.3 48460.0 48709.5 49387.3 8418.2 8597.4 8683.5 8817.8 8843.4 7671.9 11169.4 13181.9 13309.7 13473.3 10093.4 11412.1 11477.4 11597.5 11919.0 11540.1 11580.2 11583.9 11722.6 11827.4 10471.3 11717.3 12017.5 12078.3 12088.9 8777.5 8814.2 8871.5 8895.2 8991.6 11677.6 11681.6 11718.7 11732.8 11800.8 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | [#3] mootools.html Cycles:180 Average:5657.83 Median:6322.24 stddev:2961.74 (46.8%) stddev-sans-first:2951.98 10:06:23 INFO - PROCESS | 21518 | Values: 1305.9 1596.0 1609.4 1882.0 1986.4 7697.4 7865.4 7871.3 7877.1 7881.8 7832.3 7986.6 7991.6 7999.0 8008.8 2074.5 2255.6 2280.3 2296.2 2312.8 2330.7 2336.1 2341.3 2352.3 2367.2 2246.8 2299.6 2302.8 2304.7 2306.4 2217.3 2252.4 2285.5 2286.0 2298.9 2216.9 2235.4 2240.5 2247.2 2248.7 8060.2 8120.4 8126.6 8130.3 8138.5 4876.5 5016.6 5019.0 5021.8 5027.5 3145.5 3148.4 3149.3 3171.4 3212.4 999.0 1007.8 1018.2 1024.9 1066.0 11234.9 11242.4 11245.0 11247.7 11267.9 4238.5 4294.5 4397.3 4397.4 4407.5 9576.0 9593.9 9606.3 9612.9 9615.1 4515.3 5077.0 5097.8 5101.6 5110.0 4336.9 4356.7 4386.0 4412.0 4423.6 3604.2 3714.4 3719.8 3751.4 3796.3 1170.7 1187.7 1192.8 1194.4 1205.6 1149.5 1162.9 1163.4 1173.5 1198.3 7541.6 7579.6 7624.8 7663.8 7671.5 1149.2 1157.8 1158.4 1172.1 1245.1 6010.0 6024.6 6059.5 6065.1 6072.4 9282.4 9898.9 9912.9 9916.4 10040.4 9797.9 9832.7 9918.8 9932.0 9941.2 7499.4 7765.7 7866.4 7881.3 7895.3 7379.6 7441.5 7468.8 7472.3 7476.6 8656.2 8669.0 8669.4 8735.8 8958.0 8759.5 8955.1 9108.2 9117.5 9203.5 6232.1 6412.4 6422.6 6948.7 7063.6 7130.1 7349.5 7520.2 7526.7 7533.7 6888.7 7054.4 7061.4 7108.4 7183.7 7075.2 7110.9 7116.7 7211.8 7252.5 7334.4 7345.1 7461.4 7483.0 7487.6 6734.4 6748.7 6761.5 6770.3 6781.1 6870.1 6930.0 6943.2 6946.9 6974.4 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | [#4] prototype.html Cycles:180 Average:5417.80 Median:6129.19 stddev:1618.06 (26.4%) stddev-sans-first:1577.38 10:06:23 INFO - PROCESS | 21518 | Values: 356.8 362.2 364.5 366.3 367.8 6071.7 6102.0 6113.5 6126.5 6139.1 6011.1 6075.0 6089.8 6095.1 6105.4 4470.7 4557.9 4641.6 4747.7 4753.1 4709.5 4732.5 4736.1 4750.9 4753.6 4703.3 4709.5 4712.3 4718.5 4723.3 4496.0 4570.4 4642.4 4650.7 4657.4 4159.3 4174.5 4179.7 4189.4 4194.3 5700.2 5710.1 5710.8 5710.9 5721.8 5478.7 5482.7 5486.2 5486.4 5488.4 6357.7 6373.8 6377.6 6379.7 6379.9 4379.1 4552.3 4556.3 4562.5 4652.5 6606.4 6634.1 6667.6 6668.5 6674.4 4655.0 4659.6 4661.0 4663.8 4669.8 4703.3 4728.8 4732.1 4732.5 4740.8 5410.0 5410.4 5410.9 5412.1 5423.9 6292.4 6411.2 6420.9 6435.7 6437.6 1645.8 1661.8 1667.7 1670.5 1671.5 1041.7 1066.6 1070.1 1094.7 1119.3 6044.1 6131.8 6292.9 6354.6 6368.9 6682.2 6687.5 6692.3 6701.6 6702.5 6334.7 6335.2 6338.7 6347.3 6355.4 3552.1 3562.6 3599.0 3601.6 3602.9 6794.9 6895.8 6948.5 6951.8 6957.7 6822.9 6833.8 6841.0 6842.1 6845.9 6916.3 6929.1 6932.3 6933.6 6939.5 6630.9 6654.7 6669.4 6681.4 6682.0 6409.9 6541.5 6557.9 6558.9 6567.2 6890.4 6912.1 6916.8 6918.6 6931.3 4588.4 4594.8 4600.5 4603.8 4605.1 6654.1 6654.6 6658.0 6661.7 6675.2 6345.7 6484.4 6486.3 6487.5 6490.8 6402.3 6449.8 6469.9 6484.1 6484.5 6339.8 6348.1 6350.5 6357.6 6403.3 6471.1 6515.8 6516.3 6522.9 6524.0 6070.5 6184.5 6200.3 6359.8 6359.8 10:06:23 INFO - PROCESS | 21518 | 10:06:23 INFO - PROCESS | 21518 | [#5] yui.html Cycles:180 Average:15148.65 Median:4724.85 stddev:17764.51 (376.0%) stddev-sans-first:17781.51 10:06:23 INFO - PROCESS | 21518 | Values: 764.9 774.1 806.4 866.3 888.3 16620.8 16945.0 16956.6 16973.2 16975.2 15600.9 15751.6 15755.3 15763.0 15783.4 792.0 922.6 924.6 932.3 934.0 948.1 952.8 952.8 958.7 960.3 832.2 977.8 987.8 989.0 989.2 828.3 974.9 990.6 993.5 994.3 725.8 726.4 726.5 733.8 735.4 14975.9 15009.8 15162.5 15266.5 15281.8 13342.5 13360.5 13461.0 13639.8 14152.2 11415.4 11558.1 11592.8 11614.5 11749.6 3750.8 3771.9 3812.4 3867.3 3870.3 53074.7 53155.0 53624.0 53658.0 53938.5 9918.7 10053.0 10104.8 10119.9 10218.4 18007.8 18022.0 18034.2 18037.4 18069.9 6901.9 7461.7 8011.2 8309.7 8354.5 4680.4 4702.3 4724.3 4725.4 4800.2 3454.4 3464.7 3469.5 3472.0 3473.8 643.3 651.0 653.3 661.1 667.0 633.4 690.8 728.7 739.6 760.6 8700.3 8714.8 8771.9 8774.1 8832.6 667.7 748.1 758.0 770.8 781.5 4249.5 4259.8 4316.2 4403.5 4461.6 61758.0 62470.4 62779.0 63423.7 63471.4 55486.0 55706.7 56773.0 57565.4 57713.7 50393.7 50803.0 52059.5 52619.5 53040.7 8601.3 8711.6 8751.4 8818.5 8861.4 39527.6 39785.2 40296.2 40740.0 40889.2 48360.8 50145.2 50337.7 50568.5 51864.0 10982.5 11277.5 11357.0 11478.4 11519.7 12442.6 12464.7 12717.7 12805.2 13330.3 11103.7 11209.7 11362.3 11409.4 11451.2 11837.1 12178.5 12289.1 12361.9 12552.6 11615.7 11721.9 11787.2 11975.0 11991.8 10172.9 10377.6 10420.3 10453.8 10755.4 9941.3 10083.6 10159.1 10173.6 10228.4 10:06:23 INFO - PROCESS | 21518 | -------- Summary: end -------- 10:06:23 INFO - PROCESS | 21518 | 10:06:24 INFO - TEST-INFO | 21518: exit 0 10:06:24 INFO - TEST-OK | dromaeo_css | took 1111543ms 10:06:24 INFO - TEST-START | kraken 10:06:24 INFO - operating with platform_type : linux_ 10:06:24 INFO - Initialising browser for kraken test... 10:06:24 INFO - TEST-INFO | started process 21702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XglDz/profile http://localhost:51296/getInfo.html) 10:06:28 INFO - PROCESS | 21702 | __metrics Screen width/height:1600/1200 10:06:28 INFO - PROCESS | 21702 | colorDepth:24 10:06:28 INFO - PROCESS | 21702 | Browser inner width/height: 1024/697 10:06:28 INFO - PROCESS | 21702 | __metrics 10:06:29 INFO - PROCESS | 21702 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:30 INFO - TEST-INFO | 21702: exit 0 10:06:30 INFO - Browser initialized. 10:06:30 INFO - Running cycle 1/1 for kraken test... 10:06:30 INFO - TEST-INFO | started process 21791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XglDz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:41 INFO - PROCESS | 21791 | RSS: Main: 141529088 10:06:41 INFO - PROCESS | 21791 | 10:06:44 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51296/tests/kraken/driver.html?testName=audio-beat-detection) 10:06:44 INFO - PROCESS | 21791 | RSS: Main: 177532928 10:06:44 INFO - PROCESS | 21791 | 10:06:47 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51296/tests/kraken/driver.html?testName=audio-dft) 10:06:48 INFO - PROCESS | 21791 | RSS: Main: 175529984 10:06:48 INFO - PROCESS | 21791 | 10:06:51 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51296/tests/kraken/driver.html?testName=audio-fft) 10:06:51 INFO - PROCESS | 21791 | RSS: Main: 173318144 10:06:51 INFO - PROCESS | 21791 | 10:06:53 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51296/tests/kraken/driver.html?testName=audio-oscillator) 10:06:54 INFO - PROCESS | 21791 | RSS: Main: 174600192 10:06:54 INFO - PROCESS | 21791 | 10:06:56 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:57 INFO - PROCESS | 21791 | RSS: Main: 171798528 10:06:57 INFO - PROCESS | 21791 | 10:07:00 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51296/tests/kraken/driver.html?testName=imaging-darkroom) 10:07:00 INFO - PROCESS | 21791 | RSS: Main: 171483136 10:07:00 INFO - PROCESS | 21791 | 10:07:03 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51296/tests/kraken/driver.html?testName=imaging-desaturate) 10:07:04 INFO - PROCESS | 21791 | RSS: Main: 172257280 10:07:04 INFO - PROCESS | 21791 | 10:07:07 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51296/tests/kraken/driver.html?testName=json-parse-financial) 10:07:07 INFO - PROCESS | 21791 | RSS: Main: 172535808 10:07:07 INFO - PROCESS | 21791 | 10:07:09 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:07:09 INFO - PROCESS | 21791 | RSS: Main: 176828416 10:07:09 INFO - PROCESS | 21791 | 10:07:11 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:07:12 INFO - PROCESS | 21791 | RSS: Main: 174845952 10:07:12 INFO - PROCESS | 21791 | 10:07:14 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:07:14 INFO - PROCESS | 21791 | RSS: Main: 181633024 10:07:14 INFO - PROCESS | 21791 | 10:07:17 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:07:17 INFO - PROCESS | 21791 | RSS: Main: 188137472 10:07:17 INFO - PROCESS | 21791 | 10:07:20 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:07:20 INFO - PROCESS | 21791 | RSS: Main: 187854848 10:07:20 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | Cycle 1(1): loaded http://localhost:51296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51296/tests/kraken/driver.html?testName=ai-astar) 10:07:22 INFO - PROCESS | 21791 | RSS: Main: 250703872 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | __start_tp_report 10:07:22 INFO - PROCESS | 21791 | _x_x_mozilla_page_load 10:07:22 INFO - PROCESS | 21791 | _x_x_mozilla_page_load_details 10:07:22 INFO - PROCESS | 21791 | |i|pagename|runs| 10:07:22 INFO - PROCESS | 21791 | |0;ai-astar;109;110;106;109;109;111;99;109;109;108 10:07:22 INFO - PROCESS | 21791 | |1;audio-beat-detection;159;133;160;172;135;164;160;130;168;127 10:07:22 INFO - PROCESS | 21791 | |2;audio-dft;163;162;161;161;161;161;159;165;162;162 10:07:22 INFO - PROCESS | 21791 | |3;audio-fft;76;78;77;160;74;76;75;74;164;76 10:07:22 INFO - PROCESS | 21791 | |4;audio-oscillator;93;94;153;93;94;94;146;93;92;144 10:07:22 INFO - PROCESS | 21791 | |5;imaging-gaussian-blur;117;117;118;119;118;117;118;117;117;116 10:07:22 INFO - PROCESS | 21791 | |6;imaging-darkroom;146;145;147;145;147;146;146;146;146;147 10:07:22 INFO - PROCESS | 21791 | |7;imaging-desaturate;96;96;96;96;95;96;98;96;96;95 10:07:22 INFO - PROCESS | 21791 | |8;json-parse-financial;55;55;55;55;55;55;56;67;53;52 10:07:22 INFO - PROCESS | 21791 | |9;json-stringify-tinderbox;64;65;64;64;65;65;66;65;64;65 10:07:22 INFO - PROCESS | 21791 | |10;stanford-crypto-aes;78;79;78;79;81;80;86;81;79;85 10:07:22 INFO - PROCESS | 21791 | |11;stanford-crypto-ccm;118;129;124;116;112;120;112;110;111;112 10:07:22 INFO - PROCESS | 21791 | |12;stanford-crypto-pbkdf2;132;124;133;137;133;137;127;139;132;126 10:07:22 INFO - PROCESS | 21791 | |13;stanford-crypto-sha256-iterative;66;70;64;68;66;67;63;65;64;62 10:07:22 INFO - PROCESS | 21791 | __end_tp_report 10:07:22 INFO - PROCESS | 21791 | __start_cc_report 10:07:22 INFO - PROCESS | 21791 | _x_x_mozilla_cycle_collect,1078 10:07:22 INFO - PROCESS | 21791 | __end_cc_report 10:07:22 INFO - PROCESS | 21791 | __startTimestamp1461085642820__endTimestamp 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | ------- Summary: start ------- 10:07:22 INFO - PROCESS | 21791 | Number of tests: 14 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.38 (3.1%) stddev-sans-first:3.56 10:07:22 INFO - PROCESS | 21791 | Values: 109.0 110.0 106.0 109.0 109.0 111.0 99.0 109.0 109.0 108.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:160.00 stddev:17.39 (10.9%) stddev-sans-first:18.19 10:07:22 INFO - PROCESS | 21791 | Values: 159.0 133.0 160.0 172.0 135.0 164.0 160.0 130.0 168.0 127.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.59 10:07:22 INFO - PROCESS | 21791 | Values: 163.0 162.0 161.0 161.0 161.0 161.0 159.0 165.0 162.0 162.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:36.40 (47.9%) stddev-sans-first:38.08 10:07:22 INFO - PROCESS | 21791 | Values: 76.0 78.0 77.0 160.0 74.0 76.0 75.0 74.0 164.0 76.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.37 (28.4%) stddev-sans-first:27.28 10:07:22 INFO - PROCESS | 21791 | Values: 93.0 94.0 153.0 93.0 94.0 94.0 146.0 93.0 92.0 144.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 10:07:22 INFO - PROCESS | 21791 | Values: 117.0 117.0 118.0 119.0 118.0 117.0 118.0 117.0 117.0 116.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:07:22 INFO - PROCESS | 21791 | Values: 146.0 145.0 147.0 145.0 147.0 146.0 146.0 146.0 146.0 147.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 10:07:22 INFO - PROCESS | 21791 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 98.0 96.0 96.0 95.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:4.10 (7.5%) stddev-sans-first:4.34 10:07:22 INFO - PROCESS | 21791 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 56.0 67.0 53.0 52.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 10:07:22 INFO - PROCESS | 21791 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 66.0 65.0 64.0 65.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:2.80 (3.5%) stddev-sans-first:2.80 10:07:22 INFO - PROCESS | 21791 | Values: 78.0 79.0 78.0 79.0 81.0 80.0 86.0 81.0 79.0 85.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:117.00 stddev:6.33 (5.4%) stddev-sans-first:6.69 10:07:22 INFO - PROCESS | 21791 | Values: 118.0 129.0 124.0 116.0 112.0 120.0 112.0 110.0 111.0 112.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.00 Median:133.00 stddev:5.01 (3.8%) stddev-sans-first:5.32 10:07:22 INFO - PROCESS | 21791 | Values: 132.0 124.0 133.0 137.0 133.0 137.0 127.0 139.0 132.0 126.0 10:07:22 INFO - PROCESS | 21791 | 10:07:22 INFO - PROCESS | 21791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:2.42 (3.7%) stddev-sans-first:2.55 10:07:22 INFO - PROCESS | 21791 | Values: 66.0 70.0 64.0 68.0 66.0 67.0 63.0 65.0 64.0 62.0 10:07:22 INFO - PROCESS | 21791 | -------- Summary: end -------- 10:07:22 INFO - PROCESS | 21791 | 10:07:23 INFO - TEST-INFO | 21791: exit 0 10:07:23 INFO - TEST-OK | kraken | took 59503ms 10:07:23 INFO - SUITE-END | took 1171s 10:07:23 INFO - Completed test suite (00:19:31) 10:07:23 INFO - javascript benchmark 10:07:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3288.7204587610054, 3296.9340613187724, 3356.8657253709866, 3357.5299458075874, 3378.898633041009, 5353.544948679362, 5366.168243922193, 5371.301730774999, 5386.48828361306, 5393.0, 5317.6809391436545, 5378.946210537893, 5384.3807962084375, 5392.4337944515755, 5399.9730001349935, 4800.783964721596, 4882.853514394574, 4931.778069986841, 4932.210846264607, 4963.528464795857, 4832.0, 4890.14422476067, 4900.485449027854, 4938.061768264036, 4952.182889823175, 4953.182724850395, 4955.529224723664, 4968.627352948525, 4969.527894849984, 5011.398632164127, 4807.158747219258, 4867.464578896319, 4914.434839993411, 4927.556519913225, 4986.326845875797, 4842.467328593852, 4873.853784386439, 4876.731779752112, 4886.169351210303, 4888.755562221874, 5202.4277329493725, 5208.348956380452, 5240.3187585614005, 5241.082810508184, 5256.579473642099, 5590.888182236373, 5749.3388260350175, 5765.250517432749, 5784.68184249866, 5830.271216097988, 5765.1928729977835, 5769.423057694239, 5781.739821708034, 5794.88410231793, 5795.1017592273265, 5406.54044406226, 5407.594430417735, 5410.026195284847, 5410.404855465935, 5435.076037073707, 5706.9714651426475, 5856.912146317809, 5881.3530511643685, 5916.49709774674, 5946.732397042144, 5648.802291919763, 5650.039493286151, 5657.98156331856, 5665.830025099253, 5687.0, 5703.0, 5747.597668163272, 5764.913526297109, 5779.33537643168, 5786.218860453869, 5606.355269144019, 5619.831405057855, 5639.859003524863, 5682.374938756733, 5702.800401985911, 5698.287714035746, 5702.45826646468, 5704.4295570443455, 5709.68596727184, 5730.942690573124, 4344.47866256045, 4374.081442897027, 4405.845795397146, 4410.735355878657, 4424.7123936944, 3964.484616999829, 4008.6793056555407, 4016.779077150785, 4022.4770779799023, 4038.959610403917, 5465.125579907196, 5473.75368108436, 5487.42382049887, 5488.9725551371985, 5499.092649712833, 5683.715814209273, 5777.162311464814, 5785.82642520725, 5793.362730099686, 5797.188393624896, 5494.2582751328055, 5494.642848214933, 5500.22996780451, 5511.090670039479, 5519.834404967857, 4977.552020318117, 4978.651494395358, 4993.975030124899, 5001.124803159432, 5008.048470790538, 5818.44724751148, 5962.522998160137, 5979.9402005980255, 6023.6385816851125, 6050.364711705296, 5704.087346024616, 5782.277215348082, 5792.94207057924, 5812.476877080914, 5816.331121920864, 5949.52403807703, 5963.194968679173, 5963.671998039976, 5970.283565972111, 5983.833152535388, 5605.80379686709, 5648.926703926241, 5718.828435146952, 5750.942490575041, 5866.560007999503, 5816.709164541671, 5832.650040997553, 5844.94155058444, 5850.3857095006115, 5865.501432378295, 5689.061304884648, 5692.260006199168, 5709.65742055478, 5711.371749107512, 5712.343080545625, 5584.720763961867, 5625.071863142535, 5669.291338582677, 5683.857903552444, 5710.5146062585145, 5562.777488900399, 5567.805126820542, 5576.525995290283, 5581.74882130297, 5586.832395028156, 5664.830055098354, 5667.319921609434, 5685.118806584986, 5699.572532060195, 5702.543796496353, 5411.188321751769, 5439.864003399946, 5527.060399731975, 5546.694931778791, 5590.608657393944], "unit": "score", "name": "dojo.html", "value": 5327.174853526782}, {"lowerIsBetter": false, "replicates": [554.4344768336297, 557.4481263549086, 572.044685375423, 572.9369769325376, 583.3641330949265, 39487.21025579487, 40463.19073618526, 40475.79762101193, 40511.392329115086, 40545.189096218055, 42930.57069429305, 43006.35490467645, 43106.784466077705, 43447.3482897756, 43494.56505434945, 8828.690995815148, 9000.684976025841, 9045.954770226139, 9048.638054477813, 9052.502112383816, 8757.693480728176, 8923.866142007875, 8924.598393072294, 9150.359474836763, 9152.039035901234, 9135.68025119121, 9236.12256835603, 9236.353455258135, 9241.537923103851, 9244.953775231115, 9001.864972025392, 9169.724908252763, 9189.218916392114, 9190.448573085636, 9190.770230744218, 9037.277017838556, 9148.451092934445, 9162.725118246462, 9175.0, 9181.908180918172, 42453.15093698109, 42976.78511607422, 43042.56957430417, 43110.78444607757, 43130.0, 3729.925401491982, 3761.9247615047548, 3796.2217745362136, 3803.315403227418, 4294.828206871753, 32224.355512889844, 32498.67501325004, 32780.508292375634, 32935.17662058444, 33286.6671333286, 3717.5724791648768, 3778.7543809652284, 3813.3707938190164, 3819.083419979185, 3973.0, 284256.0, 286073.0, 286454.0, 286847.0, 287184.9999999979, 60468.69765651144, 62049.207785649756, 62098.689506553084, 62122.37877621166, 62180.689096554226, 71143.64428177827, 71839.0, 71893.0, 71959.0, 71968.28031719616, 17489.0, 17596.912015440095, 17708.645827083386, 17726.645467090842, 17726.91136544309, 13767.449302027806, 13840.0, 13854.16874987504, 13867.09863858866, 13867.237301948287, 21271.680924786142, 21276.893615531822, 21494.462638434165, 21518.892405537874, 22577.209797657004, 8086.959565202254, 8309.37679674027, 8311.16888311176, 8391.62237699305, 8547.017093034256, 1016.7356487313203, 1063.8297872340388, 1077.4828082520435, 1117.5250518529756, 1124.8818874018275, 30829.691703083132, 30955.380892382476, 31071.68928310733, 31160.53259201114, 31329.373412532077, 1117.5138814615668, 1141.6289705845634, 1236.5301185549613, 1238.746057058301, 1283.1082397733485, 15892.92053539748, 16095.0, 16220.594485137966, 16377.344906203618, 16417.0, 349523.0, 354002.0, 354204.0, 354225.0, 354956.0, 56416.43583564112, 56942.0, 57029.42970570241, 57098.714506428034, 57131.71434142803, 1280.6606249343931, 1427.1651084115908, 1476.2102275282673, 1483.0434369831398, 1510.9622259443602, 27484.725152749015, 27933.720662793923, 27958.72041279561, 28425.147245582666, 28875.855620722603, 42478.0, 42803.78598107114, 42937.0, 43063.56936430596, 43071.35392969171, 202351.0, 205605.0, 206641.0, 206672.0, 207113.0, 30400.695993039786, 33976.490352645225, 34212.31575368429, 34296.0, 34405.483917740756, 40839.38740918948, 41247.175056499305, 42199.57800422079, 42239.0, 44124.33813492736, 37429.0, 37709.81145094257, 38017.04957376088, 38141.618583813804, 38400.2319953605, 36432.63567364292, 36713.81643091767, 37048.81475592605, 37061.62938370582, 37316.626833731316, 35308.11729706778, 36483.45274820827, 36624.45063324105, 36767.63232367642, 36995.26009479849, 31832.314306541037, 32741.836290819345, 33131.50302745509, 33612.49581256332, 33745.662543375234, 25535.106271280416, 25811.741882581686, 25867.482650346512, 25890.22329330123, 26215.475690486466], "unit": "score", "name": "ext.html", "value": 19344.509747656004}, {"lowerIsBetter": false, "replicates": [366.65168090314194, 368.84508506427295, 389.4605970730539, 391.4734681852907, 392.6603487982894, 17433.0, 18106.728399074007, 19012.61974760506, 19466.707999379985, 19471.805281947178, 17640.911795441036, 17746.29014839408, 18535.351262705808, 18535.814641853576, 18547.0, 5656.802011929583, 5783.913241301363, 5812.331581868076, 5822.039363505017, 5822.184894114827, 4308.482982042159, 5751.65490070595, 6142.785002524913, 6349.42855143037, 6411.134496842913, 6348.143000694893, 6348.523860710442, 6357.459615932651, 6361.395667411589, 6362.204724409449, 6222.533310001745, 6262.405071518198, 6279.120923070774, 6399.360063993563, 6409.967950160266, 3852.364359880616, 5418.8916221675345, 5612.15817627355, 5621.578381621354, 5691.345495268056, 21099.261525846523, 21670.78329216719, 21804.563908721735, 21832.126714931383, 21878.781212187994, 2398.9160379386813, 2407.9200859759057, 2474.39377352548, 2525.7600527949817, 2529.7976161907004, 9976.501174941297, 10513.316634418738, 13845.584632461043, 13947.232902190375, 14452.855471445257, 1856.6286742651523, 1945.5525229197222, 1999.7900220476786, 2008.1465377214624, 2049.733534640487, 64517.0, 65245.34754652488, 65433.67283163602, 66983.0, 67350.0, 10528.631497897537, 10535.683929482127, 10536.631217907336, 10621.787564248672, 10794.082502987178, 14891.0, 15018.774718379233, 15021.0, 15117.924410377878, 15146.772798408032, 8181.550014749127, 8271.586420678943, 8328.541930193776, 8387.077421483631, 8454.28138608213, 8050.637721302555, 8098.635561399751, 8108.8378232435025, 8156.306713929383, 8308.0, 4715.457722361973, 4720.33915251865, 4748.525147485293, 4781.354517140142, 4813.855584332476, 1774.643409396358, 1820.1263393570896, 1901.9619607608047, 1910.2263583248807, 1916.2143521156258, 1026.7381817636456, 1038.5067093130704, 1045.911097556701, 1090.8472813806075, 1094.2832444748703, 16198.919005404898, 16430.8156465881, 16648.0, 16723.331066757437, 17349.56626084358, 982.8673129127619, 993.9254555908336, 1020.9693709188737, 1052.4948024947914, 1067.80779459698, 9790.363626364264, 9961.601535938626, 9974.45140517264, 10008.348622477355, 10052.899471005196, 432080.0, 437467.0, 438954.0, 443586.0, 446958.0, 73363.63318183375, 74730.0, 74782.62608686922, 74983.0, 75021.24978750142, 1059.9152067834555, 1071.4160782373624, 1091.317926296065, 1093.3986307530827, 1104.8066588347167, 15522.689546209238, 15609.375624974873, 15609.843901561293, 15626.952744214768, 15764.369425223322, 34321.48517772186, 34405.31189376248, 34725.30549388948, 35500.467492988144, 35511.93464196078, 48261.5173848257, 48454.27318590153, 48460.0, 48709.51290487192, 49387.259191112884, 8418.242358187792, 8597.398182127192, 8683.478991260292, 8817.779555511164, 8843.425177363451, 7671.88401185342, 11169.441527923735, 13181.868181318448, 13309.66725831862, 13473.258970756702, 10093.394396336244, 11412.144089193178, 11477.426128693365, 11597.478113485082, 11919.04647628205, 11540.134489913122, 11580.247283926517, 11583.884161158281, 11722.58970936013, 11827.40862956866, 10471.3193642413, 11717.296962182296, 12017.459214335551, 12078.33569153705, 12088.939555302168, 8777.51723655205, 8814.162654547808, 8871.512066836385, 8895.243904268209, 8991.55042247898, 11677.649670509898, 11681.649550513499, 11718.70703232426, 11732.765344692887, 11800.76398472043], "unit": "score", "name": "jquery.html", "value": 8985.622636713942}, {"lowerIsBetter": false, "replicates": [1305.8955283577316, 1596.0, 1609.3643011010652, 1881.9811801881976, 1986.443795737193, 7697.384209263252, 7865.410094242933, 7871.252231038056, 7877.094134174572, 7881.842363152734, 7832.255935686101, 7986.560739159344, 7991.600419978992, 7999.0, 8008.799780005503, 2074.471009892475, 2255.639097744357, 2280.2817112609473, 2296.219285442949, 2312.7918487336137, 2330.720313562375, 2336.1356298169703, 2341.274204996448, 2352.2943117064897, 2367.159658321297, 2246.8314876384256, 2299.609066458706, 2302.804261637763, 2304.746477887431, 2306.3772781349026, 2217.2904670505445, 2252.358077947785, 2285.462916214688, 2286.039863257436, 2298.9195378161853, 2216.9334919952425, 2235.3740952533317, 2240.462289050616, 2247.1797793805144, 2248.6964259824877, 8060.153683863168, 8120.4315697901175, 8126.593670316461, 8130.308923741489, 8138.470999385021, 4876.536729010738, 5016.573591244749, 5019.021290848286, 5021.824236151754, 5027.49725027498, 3145.496720524705, 3148.449021421242, 3149.291409432882, 3171.413288541627, 3212.4217640824877, 998.9800203995952, 1007.7581380468708, 1018.221060888421, 1024.8975102489692, 1065.9626913058082, 11234.943825280903, 11242.381669008202, 11245.0, 11247.718807029807, 11267.887321126847, 4238.512571054368, 4294.549072347359, 4397.34039894012, 4397.406350142754, 4407.537208593051, 9575.952120239353, 9593.856092158623, 9606.327557070937, 9612.903870961201, 9615.086566776145, 4515.345274935116, 5077.035363280965, 5097.8215762448135, 5101.591872650179, 5109.9744501277255, 4336.9132617348105, 4356.716813407118, 4386.035072284092, 4411.9558804411545, 4423.579759922803, 3604.2250916053176, 3714.4428335749312, 3719.8326075326677, 3751.4185301278344, 3796.3166630006863, 1170.695619139013, 1187.7090112922217, 1192.7674103549898, 1194.4326444938586, 1205.6202296276645, 1149.5286932357694, 1162.8837116288473, 1163.3892206591438, 1173.5423184957874, 1198.2750435986277, 7541.585212813348, 7579.583122928292, 7624.80937976555, 7663.770086897291, 7671.53970761756, 1149.1553708024596, 1157.8494795676509, 1158.4381574936149, 1172.1033409441784, 1245.0848626259692, 6009.969950150221, 6024.57827952048, 6059.515238780887, 6065.059915713072, 6072.39276072398, 9282.35023548345, 9898.851517227247, 9912.900870991341, 9916.355436896578, 10040.447775372424, 9797.902020979698, 9832.655857044969, 9918.752031199134, 9932.0, 9941.204703623693, 7499.437542184358, 7765.689372425153, 7866.410019248579, 7881.330086942559, 7895.289423951872, 7379.631018448948, 7441.516301440389, 7468.813279668052, 7472.252774722484, 7476.5514069156025, 8656.177663121993, 8669.0, 8669.436486628349, 8735.825283494167, 8958.0, 8759.518226497605, 8955.104489550993, 9108.22580080674, 9117.452952822852, 9203.493807840632, 6232.127502149612, 6412.358764123737, 6422.550421470452, 6948.6525673715105, 7063.611501367474, 7130.108736407949, 7349.4855360124275, 7520.247975202436, 7526.736564220226, 7533.660985255567, 6888.690008949709, 7054.435645148274, 7061.399781018466, 7108.360247577536, 7183.676734547063, 7075.186353569406, 7110.857782844418, 7116.679749411393, 7211.783646490614, 7252.4560657949805, 7334.4132469403385, 7345.081864766904, 7461.403087753075, 7483.027206463125, 7487.5507469552, 6734.3602357775935, 6748.6963086660235, 6761.492888033516, 6770.32296770319, 6781.084553585203, 6870.106886104774, 6930.0, 6943.236244013256, 6946.895796563157, 6974.407175389946], "unit": "score", "name": "mootools.html", "value": 4631.448198733348}, {"lowerIsBetter": false, "replicates": [356.8305055098828, 362.1670158635138, 364.5206553382302, 366.32961680125374, 367.79954924566107, 6071.666058366788, 6101.969490152548, 6113.51091912647, 6126.540509461786, 6139.140520327158, 6011.098335249715, 6075.0, 6089.817305480843, 6095.055266433699, 6105.358937311585, 4470.7317560946285, 4557.908841823161, 4641.582257596816, 4747.715137091785, 4753.0969115867965, 4709.45841228258, 4732.526747325274, 4736.100140973204, 4750.928736068961, 4753.62144977956, 4703.318018887259, 4709.5290470952805, 4712.269598212282, 4718.528147185289, 4723.338732577442, 4496.033352829141, 4570.3829982952375, 4642.419697537808, 4650.720956742606, 4657.39453870998, 4159.292920203573, 4174.478190226222, 4179.728317659343, 4189.371594260855, 4194.30793919003, 5700.230468886689, 5710.14347847822, 5710.800121995751, 5710.885782284373, 5721.828345149652, 5478.698671573062, 5482.671039737628, 5486.177073438977, 5486.3690675572425, 5488.396276409591, 6357.65032923189, 6373.808785736435, 6377.553571250014, 6379.681015949231, 6379.87240255197, 4379.080393117417, 4552.294394368878, 4556.270996640522, 4562.475315338712, 4652.488226295105, 6606.438452731523, 6634.104395906539, 6667.633280169589, 6668.466522678174, 6674.399304062657, 4655.0, 4659.5573420525, 4660.976695116503, 4663.813447462131, 4669.836555720533, 4703.341532185428, 4728.834490792875, 4732.124556956974, 4732.455767586772, 4740.762961851894, 5409.972950135303, 5410.404855465896, 5410.864728381744, 5412.134058550613, 5423.945760542423, 6292.402221788922, 6411.230652321751, 6420.935790642127, 6435.710393032231, 6437.581557198767, 1645.7942757155356, 1661.7756602858701, 1667.6998140334856, 1670.5322509697305, 1671.4818406294087, 1041.7135287795916, 1066.594694016269, 1070.1331921143742, 1094.7427354571669, 1119.3339962722168, 6044.093385992136, 6131.84670383244, 6292.874142517124, 6354.555181137369, 6368.872622547616, 6682.231543372477, 6687.531872768859, 6692.330766923366, 6701.631410272482, 6702.530822842355, 6334.746610135635, 6335.208098987627, 6338.683065846689, 6347.333529979285, 6355.396237357444, 3552.0764601203873, 3562.6437356264164, 3599.046252743025, 3601.621829707843, 3602.8919132426067, 6794.8641027180165, 6895.827604309832, 6948.5483443576, 6951.826204344932, 6957.686904089328, 6822.9317706823285, 6833.794986150423, 6840.965795170992, 6842.144731908512, 6845.863082738417, 6916.3429474200875, 6929.064576282238, 6932.306769323128, 6933.618650974144, 6939.479539034492, 6630.90053649186, 6654.667266636746, 6669.366410191024, 6681.365270299314, 6682.0, 6409.935900640934, 6541.476681865534, 6557.9342507110105, 6558.934410656023, 6567.2447668518735, 6890.44876409896, 6912.066870972354, 6916.792496225121, 6918.619475928872, 6931.341522555349, 4588.426446694163, 4594.7702614869795, 4600.539946005372, 4603.838865639686, 4605.148047611203, 6654.13496245485, 6654.567453115532, 6658.0, 6661.666916654245, 6675.165604299463, 6345.746170153327, 6484.416402523795, 6486.254080780771, 6487.54587178893, 6490.8052758417325, 6402.263739669997, 6449.838754031187, 6469.902951455826, 6484.1246431733, 6484.5460817742305, 6339.809805705836, 6348.143000694847, 6350.460210882126, 6357.554971151975, 6403.327650596807, 6471.126397936407, 6515.771947981798, 6516.315786842313, 6522.934770652233, 6523.967380163069, 6070.48400885912, 6184.536159788124, 6200.286966998853, 6359.777407790705, 6359.8092057238355], "unit": "score", "name": "prototype.html", "value": 4896.523477237764}, {"lowerIsBetter": false, "replicates": [764.9082110146783, 774.0633833061995, 806.3911746631294, 866.2896424931556, 888.293806423893, 16620.833791662095, 16945.0, 16956.576085597866, 16973.2362043708, 16975.15124243789, 15600.921995390006, 15751.60620984476, 15755.291011904463, 15763.0, 15783.447579334726, 792.0218530115303, 922.6032805893464, 924.6116631014974, 932.2774849491631, 934.0472717827812, 948.1466679987997, 952.7713348796274, 952.8094381123768, 958.712386284112, 960.2749923807515, 832.2010869565224, 977.8191034658576, 987.7678745494803, 989.0, 989.2382865193797, 828.2959484438239, 974.926880483963, 990.5542505872351, 993.5330394714473, 994.2642444591023, 725.7786375155575, 726.4188649080714, 726.5459088069956, 733.8055415314946, 735.3896266099179, 14975.850241497554, 15009.849901500955, 15162.469313573973, 15266.465673701477, 15281.847181528154, 13342.533011344653, 13360.532381366702, 13461.0, 13639.795403068962, 14152.221627810466, 11415.42922853854, 11558.133140014532, 11592.826107608393, 11614.535418583246, 11749.588764393206, 3750.79370634615, 3771.9245615087543, 3812.370958791796, 3867.3232184367903, 3870.3033453978555, 53074.73462632701, 53155.0, 53624.0, 53658.0, 53938.460615393735, 9918.702438926699, 10053.0, 10104.797904042025, 10119.898801011896, 10218.437985910698, 18007.819921800616, 18022.0, 18034.188461519265, 18037.368692095715, 18069.909650451664, 6901.930980690229, 7461.664225109775, 8011.1588283230585, 8309.709160179365, 8354.540500272422, 4680.368150299666, 4702.318163866289, 4724.267738500538, 4725.432948046257, 4800.159972004885, 3454.378211921878, 3464.6535346465657, 3469.4795780632603, 3471.9826400868337, 3473.774204676688, 643.3116565275204, 650.9707063182168, 653.2748648999607, 661.0976017735757, 666.9833254168684, 633.4235845380681, 690.7547820523641, 728.6502478810095, 739.6043116932416, 760.6044856674608, 8700.303975682056, 8714.825703485894, 8771.912280877237, 8774.078721734253, 8832.55837208137, 667.7262322447773, 748.1097493982144, 757.9924200758032, 770.7995921060565, 781.4920301803872, 4249.532551419341, 4259.829606815754, 4316.1583491219535, 4403.471583409947, 4461.598456138963, 61758.0, 62470.37529624646, 62779.0, 63423.68288158529, 63471.36528634747, 55486.0, 55706.72146639322, 56773.0, 57565.424345756845, 57713.71143144257, 50393.74803125961, 50803.0, 52059.479405205464, 52619.473805261456, 53040.73479632577, 8601.311895048506, 8711.564421779012, 8751.431156974777, 8818.470891746516, 8861.424007439497, 39527.60472395239, 39785.2042959145, 40296.194076118896, 40740.0, 40889.1822163561, 48360.75819620879, 50145.24782128198, 50337.74831125821, 50568.49431505785, 51864.0, 10982.450877456255, 11277.548898043986, 11357.0, 11478.426078695864, 11519.712007199887, 12442.626721198378, 12464.688382790502, 12717.745645087232, 12805.167664101804, 13330.26683532415, 11103.722406939569, 11209.719757005814, 11362.261453005529, 11409.429528523706, 11451.216042882143, 11837.112216583619, 12178.512859485876, 12289.07831912628, 12361.887430131332, 12552.623421297376, 11615.6515304541, 11721.941390292994, 11787.233829801036, 11975.041996640073, 11991.820122697993, 10172.949135254275, 10377.636782712569, 10420.270581059252, 10453.843192352273, 10755.408452535186, 9941.30410871232, 10083.596656133672, 10159.085682288629, 10173.643922462677, 10228.386296822215], "unit": "score", "name": "yui.html", "value": 6893.604691129361}], "name": "dromaeo_css", "value": 7246.283827398428}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 109.0, 109.0, 111.0, 99.0, 109.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [159.0, 133.0, 160.0, 172.0, 135.0, 164.0, 160.0, 130.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 159.0, 165.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 77.0, 160.0, 74.0, 76.0, 75.0, 74.0, 164.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 153.0, 93.0, 94.0, 94.0, 146.0, 93.0, 92.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 98.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 67.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 78.0, 79.0, 81.0, 80.0, 86.0, 81.0, 79.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [118.0, 129.0, 124.0, 116.0, 112.0, 120.0, 112.0, 110.0, 111.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.4}, {"lowerIsBetter": true, "replicates": [132.0, 124.0, 133.0, 137.0, 133.0, 137.0, 127.0, 139.0, 132.0, 126.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.0}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 64.0, 68.0, 66.0, 67.0, 63.0, 65.0, 64.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1497.5000000000002}]} 10:07:24 INFO - Return code: 0 10:07:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:07:24 INFO - # TBPL SUCCESS # 10:07:24 INFO - Running post-action listener: _resource_record_post_action 10:07:24 INFO - Running post-run listener: _resource_record_post_run 10:07:25 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504827904; Read time: 16; Write time: 587048 10:07:25 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251879424; Read time: 0; Write time: 375392 10:07:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252882944; Read time: 16; Write time: 211636 10:07:25 INFO - Running post-run listener: _upload_blobber_files 10:07:25 INFO - Blob upload gear active. 10:07:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:07:25 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 10:07:25 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'] 10:07:25 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 10:07:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:07:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:07:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:07:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:26 INFO - (blobuploader) - INFO - Done attempting. 10:07:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:07:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:07:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:27 INFO - (blobuploader) - INFO - Done attempting. 10:07:27 INFO - (blobuploader) - INFO - Iteration through files over. 10:07:27 INFO - Return code: 0 10:07:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:07:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:07:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4f7b1983481662f8aaaf058dc0014aa48b1d6151c2353e5f0d8c7e2a41ab3b9af09e6dd53ddc610c3a403521bde0d57b7de6d6b36474db34e8ec23a96a581da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a141139041e05466a5cc9506c4d59c185190d9d5a326b197736054c3b173ddbc494bdc030744a2e488f52960bd14d7a35f124c54f9132ad048cbc40d44337e3d"} 10:07:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:07:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:07:27 INFO - Contents: 10:07:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4f7b1983481662f8aaaf058dc0014aa48b1d6151c2353e5f0d8c7e2a41ab3b9af09e6dd53ddc610c3a403521bde0d57b7de6d6b36474db34e8ec23a96a581da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a141139041e05466a5cc9506c4d59c185190d9d5a326b197736054c3b173ddbc494bdc030744a2e488f52960bd14d7a35f124c54f9132ad048cbc40d44337e3d"} 10:07:27 INFO - Running post-run listener: copy_logs_to_upload_dir 10:07:27 INFO - Copying logs to upload dir... 10:07:27 INFO - mkdir: /builds/slave/test/build/upload/logs 10:07:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.388979 ========= master_lag: 19.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-19 10:07:46.477861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 10:07:46.481578) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958 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/d4f7b1983481662f8aaaf058dc0014aa48b1d6151c2353e5f0d8c7e2a41ab3b9af09e6dd53ddc610c3a403521bde0d57b7de6d6b36474db34e8ec23a96a581da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a141139041e05466a5cc9506c4d59c185190d9d5a326b197736054c3b173ddbc494bdc030744a2e488f52960bd14d7a35f124c54f9132ad048cbc40d44337e3d"} build_url:https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/D_v76zDJTg2-KlxfR15A4w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4f7b1983481662f8aaaf058dc0014aa48b1d6151c2353e5f0d8c7e2a41ab3b9af09e6dd53ddc610c3a403521bde0d57b7de6d6b36474db34e8ec23a96a581da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a141139041e05466a5cc9506c4d59c185190d9d5a326b197736054c3b173ddbc494bdc030744a2e488f52960bd14d7a35f124c54f9132ad048cbc40d44337e3d"}' ========= master_lag: 0.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 10:07:46.801862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 10:07:46.802216) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461084417.275258-1508988958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 10:07:46.818253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 10:07:46.818581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 10:07:46.818898) ========= ========= Total master_lag: 19.68 =========