builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1461021703.69 results: success (0) buildid: 20160418094943 builduid: 82cf067085264d8d8a7159b7c61cf302 revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.688419) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.688934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.689269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.702755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.703064) ========= 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-1461021703.290274-1579861013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 16:21:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-04-18 16:21:44 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.918010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.918393) ========= 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-1461021703.290274-1579861013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020247 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.968655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:43.969060) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a229bf7891d7b453eb6e5269c11ace513e400a4 --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 1a229bf7891d7b453eb6e5269c11ace513e400a4 --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-1461021703.290274-1579861013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 16:21:44,251 truncating revision to first 12 chars 2016-04-18 16:21:44,251 Setting DEBUG logging. 2016-04-18 16:21:44,251 attempt 1/10 2016-04-18 16:21:44,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a229bf7891d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 16:21:44,529 unpacking tar archive at: mozilla-aurora-1a229bf7891d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:44.555838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:44.556658) ========= script_repo_revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:44.557676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:44.558406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:21:44.569990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-18 16:21:44.570322) ========= /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-1461021703.290274-1579861013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:21:44 INFO - MultiFileLogger online at 20160418 16:21:44 in /builds/slave/test 16:21:44 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 16:21:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:44 INFO - {'append_to_log': False, 16:21:44 INFO - 'base_work_dir': '/builds/slave/test', 16:21:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:21:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:44 INFO - 'branch': 'Mozilla-Aurora', 16:21:44 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:44 INFO - 'config_files': ('talos/linux_config.py',), 16:21:44 INFO - 'default_actions': ('clobber', 16:21:44 INFO - 'read-buildbot-config', 16:21:44 INFO - 'download-and-extract', 16:21:44 INFO - 'populate-webroot', 16:21:44 INFO - 'create-virtualenv', 16:21:44 INFO - 'install', 16:21:44 INFO - 'run-tests'), 16:21:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:44 INFO - 'download_minidump_stackwalk': True, 16:21:44 INFO - 'download_symbols': 'ondemand', 16:21:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:44 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:44 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:44 INFO - 'installer_path': 'installer.exe', 16:21:44 INFO - 'log_level': 'info', 16:21:44 INFO - 'log_name': 'talos', 16:21:44 INFO - 'log_to_console': True, 16:21:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:21:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:21:44 INFO - 'opt_config_files': (), 16:21:44 INFO - 'pip_index': False, 16:21:44 INFO - 'sps_profile': False, 16:21:44 INFO - 'sps_profile_interval': 0, 16:21:44 INFO - 'suite': 'dromaeojs', 16:21:44 INFO - 'system_bits': '32', 16:21:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:44 INFO - 'title': 'talos-linux64-ix-060', 16:21:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:44 INFO - 'use_talos_json': True, 16:21:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:44 INFO - 'work_dir': 'build'} 16:21:44 INFO - ##### 16:21:44 INFO - ##### Running clobber step. 16:21:44 INFO - ##### 16:21:44 INFO - Running pre-action listener: _resource_record_pre_action 16:21:44 INFO - Running main action method: clobber 16:21:44 INFO - rmtree: /builds/slave/test/build 16:21:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:45 INFO - Running post-action listener: _resource_record_post_action 16:21:45 INFO - ##### 16:21:45 INFO - ##### Running read-buildbot-config step. 16:21:45 INFO - ##### 16:21:45 INFO - Running pre-action listener: _resource_record_pre_action 16:21:45 INFO - Running main action method: read_buildbot_config 16:21:45 INFO - Using buildbot properties: 16:21:45 INFO - { 16:21:45 INFO - "project": "", 16:21:45 INFO - "product": "firefox", 16:21:45 INFO - "script_repo_revision": "production", 16:21:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:21:45 INFO - "repository": "", 16:21:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:21:45 INFO - "buildid": "20160418094943", 16:21:45 INFO - "pgo_build": "True", 16:21:45 INFO - "basedir": "/builds/slave/test", 16:21:45 INFO - "buildnumber": 171, 16:21:45 INFO - "slavename": "talos-linux64-ix-060", 16:21:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:21:45 INFO - "platform": "ubuntu64_hw", 16:21:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:21:45 INFO - "branch": "mozilla-aurora", 16:21:45 INFO - "repo_path": "releases/mozilla-aurora", 16:21:45 INFO - "revision": "1a229bf7891d7b453eb6e5269c11ace513e400a4", 16:21:45 INFO - "stage_platform": "linux64-pgo", 16:21:45 INFO - "builduid": "82cf067085264d8d8a7159b7c61cf302", 16:21:45 INFO - "slavebuilddir": "test" 16:21:45 INFO - } 16:21:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:21:45 INFO - Running post-action listener: _resource_record_post_action 16:21:45 INFO - ##### 16:21:45 INFO - ##### Running download-and-extract step. 16:21:45 INFO - ##### 16:21:45 INFO - Running pre-action listener: _resource_record_pre_action 16:21:45 INFO - Running main action method: download_and_extract 16:21:45 INFO - mkdir: /builds/slave/test/build/tests 16:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:45 INFO - https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:46 INFO - Downloaded 1448 bytes. 16:21:46 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:21:46 INFO - Using the following test package requirements: 16:21:46 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:21:46 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:21:46 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:21:46 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'jsshell-linux-x86_64.zip'], 16:21:46 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:21:46 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:21:46 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:21:46 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:21:46 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:21:46 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:21:46 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:21:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:21:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:46 INFO - https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:47 INFO - Downloaded 23352420 bytes. 16:21:47 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'] 16:21:47 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 16:21:48 INFO - Return code: 0 16:21:48 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 16:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:48 INFO - https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:49 INFO - Downloaded 23352420 bytes. 16:21:49 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'] 16:21:49 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 16:21:51 INFO - Return code: 0 16:21: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')]} 16:21:51 INFO - https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:21:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:21:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:21:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:51 INFO - Downloaded 10845168 bytes. 16:21:51 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'] 16:21:51 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 16:21:52 INFO - Return code: 0 16:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:52 INFO - https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:21:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:21:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:21:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLAJ4GpLT_m44a3EQbmnow/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 16:21:53 INFO - Downloaded 60595577 bytes. 16:21:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:21:53 INFO - mkdir: /builds/slave/test/properties 16:21:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:53 INFO - Contents: 16:21:53 INFO - build_url:https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:21:54 INFO - Running post-action listener: _resource_record_post_action 16:21:54 INFO - Running post-action listener: set_extra_try_arguments 16:21:54 INFO - ##### 16:21:54 INFO - ##### Running populate-webroot step. 16:21:54 INFO - ##### 16:21:54 INFO - Running pre-action listener: _resource_record_pre_action 16:21:54 INFO - Running main action method: populate_webroot 16:21:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:54 INFO - '--tppagecycles', 16:21:54 INFO - '7'], 16:21:54 INFO - 'tests': ['tsvgm']}}, 16:21:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:21:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:21:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:21:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'tests': ['damp', 'tps']}, 16:21:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['damp', 'tps']}, 16:21:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:21:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:54 INFO - 'other': {'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore', 16:21:54 INFO - 'tabpaint']}, 16:21:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore', 16:21:54 INFO - 'tabpaint']}, 16:21:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore', 16:21:54 INFO - 'tabpaint']}, 16:21:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore', 16:21:54 INFO - 'tabpaint']}, 16:21:54 INFO - 'other_l64': {'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore', 16:21:54 INFO - 'tabpaint']}, 16:21:54 INFO - 'other_nol64': {'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore', 16:21:54 INFO - 'tabpaint']}, 16:21:54 INFO - 'svgr': {'tests': ['tsvgx', 16:21:54 INFO - 'tsvgr_opacity', 16:21:54 INFO - 'tart', 16:21:54 INFO - 'tscrollx', 16:21:54 INFO - 'cart']}, 16:21:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tsvgx', 16:21:54 INFO - 'tsvgr_opacity', 16:21:54 INFO - 'tart', 16:21:54 INFO - 'tscrollx', 16:21:54 INFO - 'cart']}, 16:21:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'tests': ['tp5o']}, 16:21:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tp5o']}, 16:21:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--xperf_path', 16:21:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:54 INFO - 'tests': ['tp5n']}, 16:21:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s', 16:21:54 INFO - '--xperf_path', 16:21:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:54 INFO - 'tests': ['tp5n']}}, 16:21:54 INFO - 'talos.zip': {'path': '', 16:21:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:54 INFO - Running post-action listener: _resource_record_post_action 16:21:54 INFO - ##### 16:21:54 INFO - ##### Running create-virtualenv step. 16:21:54 INFO - ##### 16:21:54 INFO - Running pre-action listener: _resource_record_pre_action 16:21:54 INFO - Running main action method: create_virtualenv 16:21:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:54 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 16:21:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:54 INFO - Using real prefix '/usr' 16:21:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:57 INFO - Installing pip.................done. 16:21:57 INFO - Return code: 0 16:21:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:21:57 INFO - Using env: {'DISPLAY': ':0', 16:21:57 INFO - 'HOME': '/home/cltbld', 16:21:57 INFO - 'LANG': 'en_US.UTF-8', 16:21:57 INFO - 'LANGUAGE': 'en_US:en', 16:21:57 INFO - 'LOGNAME': 'cltbld', 16:21:57 INFO - 'MAIL': '/var/mail/cltbld', 16:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:57 INFO - 'MOZ_NO_REMOTE': '1', 16:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:57 INFO - 'NO_EM_RESTART': '1', 16:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:57 INFO - 'PWD': '/builds/slave/test', 16:21:57 INFO - 'SHELL': '/bin/bash', 16:21:57 INFO - 'SHLVL': '1', 16:21:57 INFO - 'TERM': 'linux', 16:21:57 INFO - 'TMOUT': '86400', 16:21:57 INFO - 'USER': 'cltbld', 16:21:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:57 INFO - '_': '/tools/buildbot/bin/python'} 16:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:57 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 16:21:57 INFO - Cleaning up... 16:21:57 INFO - Return code: 0 16:21:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:21:57 INFO - Using env: {'DISPLAY': ':0', 16:21:57 INFO - 'HOME': '/home/cltbld', 16:21:57 INFO - 'LANG': 'en_US.UTF-8', 16:21:57 INFO - 'LANGUAGE': 'en_US:en', 16:21:57 INFO - 'LOGNAME': 'cltbld', 16:21:57 INFO - 'MAIL': '/var/mail/cltbld', 16:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:57 INFO - 'MOZ_NO_REMOTE': '1', 16:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:57 INFO - 'NO_EM_RESTART': '1', 16:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:57 INFO - 'PWD': '/builds/slave/test', 16:21:57 INFO - 'SHELL': '/bin/bash', 16:21:57 INFO - 'SHLVL': '1', 16:21:57 INFO - 'TERM': 'linux', 16:21:57 INFO - 'TMOUT': '86400', 16:21:57 INFO - 'USER': 'cltbld', 16:21:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:57 INFO - '_': '/tools/buildbot/bin/python'} 16:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:57 INFO - Downloading/unpacking psutil>=0.7.1 16:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:59 INFO - Installing collected packages: psutil 16:21:59 INFO - Running setup.py install for psutil 16:21:59 INFO - building 'psutil._psutil_linux' extension 16:21:59 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 16:22:00 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 16:22:00 INFO - building 'psutil._psutil_posix' extension 16:22:00 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 16:22:00 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 16:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:00 INFO - Successfully installed psutil 16:22:00 INFO - Cleaning up... 16:22:00 INFO - Return code: 0 16:22:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:00 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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:22:00 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 16:22:00 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 16:22:00 INFO - Using env: {'DISPLAY': ':0', 16:22:00 INFO - 'HOME': '/home/cltbld', 16:22:00 INFO - 'LANG': 'en_US.UTF-8', 16:22:00 INFO - 'LANGUAGE': 'en_US:en', 16:22:00 INFO - 'LOGNAME': 'cltbld', 16:22:00 INFO - 'MAIL': '/var/mail/cltbld', 16:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:00 INFO - 'MOZ_NO_REMOTE': '1', 16:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:00 INFO - 'NO_EM_RESTART': '1', 16:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:00 INFO - 'PWD': '/builds/slave/test', 16:22:00 INFO - 'SHELL': '/bin/bash', 16:22:00 INFO - 'SHLVL': '1', 16:22:00 INFO - 'TERM': 'linux', 16:22:00 INFO - 'TMOUT': '86400', 16:22:00 INFO - 'USER': 'cltbld', 16:22:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:00 INFO - '_': '/tools/buildbot/bin/python'} 16:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:22:02 INFO - Installing collected packages: mozsystemmonitor 16:22:02 INFO - Running setup.py install for mozsystemmonitor 16:22:02 INFO - Successfully installed mozsystemmonitor 16:22:02 INFO - Cleaning up... 16:22:02 INFO - Return code: 0 16:22:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:02 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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:22:02 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 16:22:02 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 16:22:02 INFO - Using env: {'DISPLAY': ':0', 16:22:02 INFO - 'HOME': '/home/cltbld', 16:22:02 INFO - 'LANG': 'en_US.UTF-8', 16:22:02 INFO - 'LANGUAGE': 'en_US:en', 16:22:02 INFO - 'LOGNAME': 'cltbld', 16:22:02 INFO - 'MAIL': '/var/mail/cltbld', 16:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:02 INFO - 'MOZ_NO_REMOTE': '1', 16:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:02 INFO - 'NO_EM_RESTART': '1', 16:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:02 INFO - 'PWD': '/builds/slave/test', 16:22:02 INFO - 'SHELL': '/bin/bash', 16:22:02 INFO - 'SHLVL': '1', 16:22:02 INFO - 'TERM': 'linux', 16:22:02 INFO - 'TMOUT': '86400', 16:22:02 INFO - 'USER': 'cltbld', 16:22:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:02 INFO - '_': '/tools/buildbot/bin/python'} 16:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:22:02 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 16:22:02 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 16:22:02 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 16:22:02 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 16:22:02 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 16:22:02 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 16:22:04 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:05 INFO - Downloading docopt-0.6.1.tar.gz 16:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:05 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:05 INFO - Running setup.py install for blobuploader 16:22:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:05 INFO - Running setup.py install for requests 16:22:06 INFO - Running setup.py install for docopt 16:22:06 INFO - Successfully installed blobuploader requests docopt 16:22:06 INFO - Cleaning up... 16:22:06 INFO - Return code: 0 16:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:06 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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:22:06 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 16:22:06 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 16:22:06 INFO - Using env: {'DISPLAY': ':0', 16:22:06 INFO - 'HOME': '/home/cltbld', 16:22:06 INFO - 'LANG': 'en_US.UTF-8', 16:22:06 INFO - 'LANGUAGE': 'en_US:en', 16:22:06 INFO - 'LOGNAME': 'cltbld', 16:22:06 INFO - 'MAIL': '/var/mail/cltbld', 16:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:06 INFO - 'MOZ_NO_REMOTE': '1', 16:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:06 INFO - 'NO_EM_RESTART': '1', 16:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:06 INFO - 'PWD': '/builds/slave/test', 16:22:06 INFO - 'SHELL': '/bin/bash', 16:22:06 INFO - 'SHLVL': '1', 16:22:06 INFO - 'TERM': 'linux', 16:22:06 INFO - 'TMOUT': '86400', 16:22:06 INFO - 'USER': 'cltbld', 16:22:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:06 INFO - '_': '/tools/buildbot/bin/python'} 16:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:06 INFO - Running setup.py (path:/tmp/pip-ucm8Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:06 INFO - Running setup.py (path:/tmp/pip-RA91Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:06 INFO - Running setup.py (path:/tmp/pip-quGjhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:06 INFO - Running setup.py (path:/tmp/pip-7Rl1wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:06 INFO - Running setup.py (path:/tmp/pip-FUNLyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:06 INFO - Running setup.py (path:/tmp/pip-ul_aux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:06 INFO - Running setup.py (path:/tmp/pip-Zet74O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:07 INFO - Running setup.py (path:/tmp/pip-15105Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:07 INFO - Running setup.py (path:/tmp/pip-3fDepE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:07 INFO - Running setup.py (path:/tmp/pip-TRgiqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:07 INFO - Running setup.py (path:/tmp/pip-6_YfG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:07 INFO - Running setup.py (path:/tmp/pip-AYcZ1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:07 INFO - Running setup.py (path:/tmp/pip-xtx44G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:07 INFO - Running setup.py (path:/tmp/pip-maFKd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:07 INFO - Running setup.py (path:/tmp/pip-jvTUkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:07 INFO - Running setup.py (path:/tmp/pip-ngwEmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:07 INFO - Running setup.py (path:/tmp/pip-rpcZ6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:07 INFO - Running setup.py install for manifestparser 16:22:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:07 INFO - Running setup.py install for mozcrash 16:22:07 INFO - Running setup.py install for mozdebug 16:22:08 INFO - Running setup.py install for mozdevice 16:22:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Running setup.py install for mozfile 16:22:08 INFO - Running setup.py install for mozhttpd 16:22:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Running setup.py install for mozinfo 16:22:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Running setup.py install for mozInstall 16:22:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Running setup.py install for mozleak 16:22:08 INFO - Running setup.py install for mozlog 16:22:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Running setup.py install for moznetwork 16:22:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:22:08 INFO - Running setup.py install for mozprocess 16:22:08 INFO - Running setup.py install for mozprofile 16:22:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:22:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:22:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:22:09 INFO - Running setup.py install for mozrunner 16:22:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:22:09 INFO - Running setup.py install for mozscreenshot 16:22:09 INFO - Running setup.py install for moztest 16:22:09 INFO - Running setup.py install for mozversion 16:22:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:22:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:22:09 INFO - Cleaning up... 16:22:09 INFO - Return code: 0 16:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:09 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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:22:09 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 16:22:09 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 16:22:09 INFO - Using env: {'DISPLAY': ':0', 16:22:09 INFO - 'HOME': '/home/cltbld', 16:22:09 INFO - 'LANG': 'en_US.UTF-8', 16:22:09 INFO - 'LANGUAGE': 'en_US:en', 16:22:09 INFO - 'LOGNAME': 'cltbld', 16:22:09 INFO - 'MAIL': '/var/mail/cltbld', 16:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:09 INFO - 'MOZ_NO_REMOTE': '1', 16:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:09 INFO - 'NO_EM_RESTART': '1', 16:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:09 INFO - 'PWD': '/builds/slave/test', 16:22:09 INFO - 'SHELL': '/bin/bash', 16:22:09 INFO - 'SHLVL': '1', 16:22:09 INFO - 'TERM': 'linux', 16:22:09 INFO - 'TMOUT': '86400', 16:22:09 INFO - 'USER': 'cltbld', 16:22:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:09 INFO - '_': '/tools/buildbot/bin/python'} 16:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:09 INFO - Running setup.py (path:/tmp/pip-rOS_jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:09 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)) 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:09 INFO - Running setup.py (path:/tmp/pip-h0EIlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:09 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)) 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:09 INFO - Running setup.py (path:/tmp/pip-gI2nNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:09 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)) 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:09 INFO - Running setup.py (path:/tmp/pip-lVgB2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:10 INFO - Running setup.py (path:/tmp/pip-7jaeeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:10 INFO - Running setup.py (path:/tmp/pip-eGrjB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:10 INFO - Running setup.py (path:/tmp/pip-JlebhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:10 INFO - Running setup.py (path:/tmp/pip-ZFGmjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:10 INFO - Running setup.py (path:/tmp/pip-ipdoAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:10 INFO - Running setup.py (path:/tmp/pip-jpZYPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:10 INFO - Running setup.py (path:/tmp/pip-7st1X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:10 INFO - Running setup.py (path:/tmp/pip-LSvJ73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:10 INFO - Running setup.py (path:/tmp/pip-h5GuYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:10 INFO - Running setup.py (path:/tmp/pip-0LBd96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:10 INFO - Running setup.py (path:/tmp/pip-yLTgTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:10 INFO - Running setup.py (path:/tmp/pip-jdG4FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:10 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)) 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:10 INFO - Running setup.py (path:/tmp/pip-FbIuwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:13 INFO - Downloading blessings-1.6.tar.gz 16:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:22:13 INFO - Installing collected packages: blessings 16:22:13 INFO - Running setup.py install for blessings 16:22:13 INFO - Successfully installed blessings 16:22:13 INFO - Cleaning up... 16:22:13 INFO - Return code: 0 16:22:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:13 INFO - Reading from file tmpfile_stdout 16:22:13 INFO - Current package versions: 16:22:13 INFO - argparse == 1.2.1 16:22:13 INFO - blessings == 1.6 16:22:13 INFO - blobuploader == 1.2.4 16:22:13 INFO - docopt == 0.6.1 16:22:13 INFO - manifestparser == 1.1 16:22:13 INFO - mozInstall == 1.12 16:22:13 INFO - mozcrash == 0.17 16:22:13 INFO - mozdebug == 0.1 16:22:13 INFO - mozdevice == 0.48 16:22:13 INFO - mozfile == 1.2 16:22:13 INFO - mozhttpd == 0.7 16:22:13 INFO - mozinfo == 0.9 16:22:13 INFO - mozleak == 0.1 16:22:13 INFO - mozlog == 3.1 16:22:13 INFO - moznetwork == 0.27 16:22:13 INFO - mozprocess == 0.22 16:22:13 INFO - mozprofile == 0.28 16:22:13 INFO - mozrunner == 6.11 16:22:13 INFO - mozscreenshot == 0.1 16:22:13 INFO - mozsystemmonitor == 0.0 16:22:13 INFO - moztest == 0.7 16:22:13 INFO - mozversion == 1.4 16:22:13 INFO - psutil == 3.1.1 16:22:13 INFO - requests == 1.2.3 16:22:13 INFO - wsgiref == 0.1.2 16:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:13 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')]} 16:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:13 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')]} 16:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:13 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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:22:13 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 16:22:13 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 16:22:13 INFO - Using env: {'DISPLAY': ':0', 16:22:13 INFO - 'HOME': '/home/cltbld', 16:22:13 INFO - 'LANG': 'en_US.UTF-8', 16:22:13 INFO - 'LANGUAGE': 'en_US:en', 16:22:13 INFO - 'LOGNAME': 'cltbld', 16:22:13 INFO - 'MAIL': '/var/mail/cltbld', 16:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:13 INFO - 'MOZ_NO_REMOTE': '1', 16:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:13 INFO - 'NO_EM_RESTART': '1', 16:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:13 INFO - 'PWD': '/builds/slave/test', 16:22:13 INFO - 'SHELL': '/bin/bash', 16:22:13 INFO - 'SHLVL': '1', 16:22:13 INFO - 'TERM': 'linux', 16:22:13 INFO - 'TMOUT': '86400', 16:22:13 INFO - 'USER': 'cltbld', 16:22:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:13 INFO - '_': '/tools/buildbot/bin/python'} 16:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 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)) 16:22:13 INFO - Cleaning up... 16:22:13 INFO - Return code: 0 16:22:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:22:13 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')]} 16:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:13 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')]} 16:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:13 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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:22:13 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 16:22:13 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 16:22:13 INFO - Using env: {'DISPLAY': ':0', 16:22:13 INFO - 'HOME': '/home/cltbld', 16:22:13 INFO - 'LANG': 'en_US.UTF-8', 16:22:13 INFO - 'LANGUAGE': 'en_US:en', 16:22:13 INFO - 'LOGNAME': 'cltbld', 16:22:13 INFO - 'MAIL': '/var/mail/cltbld', 16:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:13 INFO - 'MOZ_NO_REMOTE': '1', 16:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:13 INFO - 'NO_EM_RESTART': '1', 16:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:13 INFO - 'PWD': '/builds/slave/test', 16:22:13 INFO - 'SHELL': '/bin/bash', 16:22:13 INFO - 'SHLVL': '1', 16:22:13 INFO - 'TERM': 'linux', 16:22:13 INFO - 'TMOUT': '86400', 16:22:13 INFO - 'USER': 'cltbld', 16:22:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:13 INFO - '_': '/tools/buildbot/bin/python'} 16:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:13 INFO - Downloading/unpacking jsonschema 16:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:22:15 INFO - Downloading/unpacking functools32 (from jsonschema) 16:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:16 INFO - Downloading functools32-3.2.3-2.tar.gz 16:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:22:16 INFO - warning: no files found matching '*.txt' 16:22:16 INFO - no previously-included directories found matching 'build' 16:22:16 INFO - no previously-included directories found matching 'dist' 16:22:16 INFO - no previously-included directories found matching '.git*' 16:22:16 INFO - Installing collected packages: jsonschema, functools32 16:22:16 INFO - Running setup.py install for functools32 16:22:16 INFO - warning: no files found matching '*.txt' 16:22:16 INFO - no previously-included directories found matching 'build' 16:22:16 INFO - no previously-included directories found matching 'dist' 16:22:16 INFO - no previously-included directories found matching '.git*' 16:22:16 INFO - Successfully installed jsonschema functools32 16:22:16 INFO - Cleaning up... 16:22:16 INFO - Return code: 0 16:22:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:22:16 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')]} 16:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:16 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')]} 16:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:16 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 0x7f3fac095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, '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-1461021703.290274-1579861013', '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 16:22:16 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 16:22:16 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 16:22:16 INFO - Using env: {'DISPLAY': ':0', 16:22:16 INFO - 'HOME': '/home/cltbld', 16:22:16 INFO - 'LANG': 'en_US.UTF-8', 16:22:16 INFO - 'LANGUAGE': 'en_US:en', 16:22:16 INFO - 'LOGNAME': 'cltbld', 16:22:16 INFO - 'MAIL': '/var/mail/cltbld', 16:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:16 INFO - 'MOZ_NO_REMOTE': '1', 16:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:16 INFO - 'NO_EM_RESTART': '1', 16:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:16 INFO - 'PWD': '/builds/slave/test', 16:22:16 INFO - 'SHELL': '/bin/bash', 16:22:16 INFO - 'SHLVL': '1', 16:22:16 INFO - 'TERM': 'linux', 16:22:16 INFO - 'TMOUT': '86400', 16:22:16 INFO - 'USER': 'cltbld', 16:22:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:16 INFO - '_': '/tools/buildbot/bin/python'} 16:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:16 INFO - Downloading/unpacking flake8 16:22:16 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 16:22:16 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 16:22:16 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 16:22:16 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 16:22:16 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 16:22:16 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 16:22:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:22:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:22:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:22:19 INFO - no previously-included directories found matching 'docs/_build' 16:22:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:22:19 INFO - Running setup.py install for pep8 16:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:22:19 INFO - no previously-included directories found matching 'docs/_build' 16:22:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:22:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:22:19 INFO - Cleaning up... 16:22:19 INFO - Return code: 0 16:22:19 INFO - Running post-action listener: _resource_record_post_action 16:22:19 INFO - Running post-action listener: _start_resource_monitoring 16:22:19 INFO - Starting resource monitoring. 16:22:19 INFO - ##### 16:22:19 INFO - ##### Running install step. 16:22:19 INFO - ##### 16:22:19 INFO - Running pre-action listener: _resource_record_pre_action 16:22:19 INFO - Running main action method: install 16:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:19 INFO - Reading from file tmpfile_stdout 16:22:19 INFO - Detecting whether we're running mozinstall >=1.0... 16:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:22:20 INFO - Reading from file tmpfile_stdout 16:22:20 INFO - Output received: 16:22:20 INFO - Usage: mozinstall [options] installer 16:22:20 INFO - Options: 16:22:20 INFO - -h, --help show this help message and exit 16:22:20 INFO - -d DEST, --destination=DEST 16:22:20 INFO - Directory to install application into. [default: 16:22:20 INFO - "/builds/slave/test"] 16:22:20 INFO - --app=APP Application being installed. [default: firefox] 16:22:20 INFO - mkdir: /builds/slave/test/build/application 16:22:20 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'] 16:22:20 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 16:22:35 INFO - Reading from file tmpfile_stdout 16:22:35 INFO - Output received: 16:22:35 INFO - /builds/slave/test/build/application/firefox/firefox 16:22:35 INFO - Running post-action listener: _resource_record_post_action 16:22:35 INFO - ##### 16:22:35 INFO - ##### Running run-tests step. 16:22:35 INFO - ##### 16:22:35 INFO - Running pre-action listener: _resource_record_pre_action 16:22:35 INFO - Running main action method: run_tests 16:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:35 INFO - Python 2.7.3 16:22:35 INFO - Return code: 0 16:22:35 INFO - grabbing minidump binary from tooltool 16:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:35 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 0x2673160>, '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 0x2674060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26744f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:35 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 16:22:35 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 16:22:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:35 INFO - Return code: 0 16:22:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:22:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:22:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:22:36 INFO - Return code: 0 16:22:36 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/LLAJ4GpLT_m44a3EQbmnow/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 16:22:36 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/LLAJ4GpLT_m44a3EQbmnow/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 16:22:36 INFO - Using env: {'DISPLAY': ':0', 16:22:36 INFO - 'HOME': '/home/cltbld', 16:22:36 INFO - 'LANG': 'en_US.UTF-8', 16:22:36 INFO - 'LANGUAGE': 'en_US:en', 16:22:36 INFO - 'LOGNAME': 'cltbld', 16:22:36 INFO - 'MAIL': '/var/mail/cltbld', 16:22:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:36 INFO - 'MOZ_NO_REMOTE': '1', 16:22:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:36 INFO - 'NO_EM_RESTART': '1', 16:22:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:36 INFO - 'PWD': '/builds/slave/test', 16:22:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:36 INFO - 'SHELL': '/bin/bash', 16:22:36 INFO - 'SHLVL': '1', 16:22:36 INFO - 'TERM': 'linux', 16:22:36 INFO - 'TMOUT': '86400', 16:22:36 INFO - 'USER': 'cltbld', 16:22:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461021703.290274-1579861013', 16:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:36 INFO - '_': '/tools/buildbot/bin/python'} 16:22:36 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/LLAJ4GpLT_m44a3EQbmnow/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 16:22:36 INFO - mozversion application_buildid: 20160418094943 16:22:36 INFO - mozversion application_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 16:22:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:22:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:36 INFO - mozversion application_name: Firefox 16:22:36 INFO - mozversion application_remotingname: firefox-dev 16:22:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:22:36 INFO - mozversion application_vendor: Mozilla 16:22:36 INFO - mozversion application_version: 47.0a2 16:22:36 INFO - mozversion platform_buildid: 20160418094943 16:22:36 INFO - mozversion platform_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 16:22:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:22:36 INFO - mozversion platform_version: 47.0a2 16:22:36 INFO - using testdate: 1461021756 16:22:36 INFO - actual date: 1461021756 16:22:36 INFO - starting webserver on 'localhost:56675' 16:22:36 INFO - SUITE-START | Running 2 tests 16:22:36 INFO - TEST-START | dromaeo_css 16:22:36 INFO - operating with platform_type : linux_ 16:22:36 INFO - Initialising browser for dromaeo_css test... 16:22:36 INFO - TEST-INFO | started process 24970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw5NyJG/profile http://localhost:56675/getInfo.html) 16:22:40 INFO - PROCESS | 24970 | __metrics Screen width/height:1600/1200 16:22:40 INFO - PROCESS | 24970 | colorDepth:24 16:22:40 INFO - PROCESS | 24970 | Browser inner width/height: 1024/697 16:22:40 INFO - PROCESS | 24970 | __metrics 16:22:41 INFO - PROCESS | 24970 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:22:42 INFO - TEST-INFO | 24970: exit 0 16:22:42 INFO - Browser initialized. 16:22:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:22:42 INFO - TEST-INFO | started process 25058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw5NyJG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:54 INFO - PROCESS | 25058 | RSS: Main: 141803520 16:22:54 INFO - PROCESS | 25058 | 16:23:46 INFO - PROCESS | 25058 | 1461021826035 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] 16:25:53 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:56675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56675/tests/dromaeo/cssquery-ext.html) 16:25:54 INFO - PROCESS | 25058 | RSS: Main: 221548544 16:25:54 INFO - PROCESS | 25058 | 16:28:56 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:56675/tests/dromaeo/cssquery-ext.html (next: http://localhost:56675/tests/dromaeo/cssquery-jquery.html) 16:28:57 INFO - PROCESS | 25058 | RSS: Main: 215773184 16:28:57 INFO - PROCESS | 25058 | 16:31:59 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:56675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56675/tests/dromaeo/cssquery-mootools.html) 16:31:59 INFO - PROCESS | 25058 | RSS: Main: 224104448 16:31:59 INFO - PROCESS | 25058 | 16:35:01 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:56675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56675/tests/dromaeo/cssquery-prototype.html) 16:35:02 INFO - PROCESS | 25058 | RSS: Main: 204021760 16:35:02 INFO - PROCESS | 25058 | 16:38:04 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:56675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56675/tests/dromaeo/cssquery-yui.html) 16:38:05 INFO - PROCESS | 25058 | RSS: Main: 207081472 16:38:05 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:56675/tests/dromaeo/cssquery-yui.html (next: http://localhost:56675/tests/dromaeo/cssquery-dojo.html) 16:41:07 INFO - PROCESS | 25058 | RSS: Main: 254005248 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | __start_tp_report 16:41:07 INFO - PROCESS | 25058 | _x_x_mozilla_page_load 16:41:07 INFO - PROCESS | 25058 | _x_x_mozilla_page_load_details 16:41:07 INFO - PROCESS | 25058 | |i|pagename|runs| 16:41:07 INFO - PROCESS | 25058 | |0;dojo.html;3329.151066478048;3365.444701624234;3375.6118046424654;3385.1029477188536;3402.0814380117367;5436.04869147899;5471.015217260897;5495.6702597844105;5516.089845175551;5539.501444869961;5486;5526.944730552693;5531;5532.30846144232;5542.279503664518;4856.125897338477;4992.475790042039;5030.82392116276;5109.540141387274;5116.309298244727;4940.1601727706375;5023.799048038074;5026.346574945252;5030.044291584605;5032.194848824189;4976.950230497685;5025.899482010358;5038.647294689373;5043.268726034723;5051.5453609175165;4948.1093403187415;5036.068327359413;5090.032893750175;5093.847184584469;5097.7960881564695;4867.51324867514;5006.5744411725045;5023.14606516893;5038.521340472649;5076.796928122871;5193.662411943212;5263.157894736823;5264.184051472028;5267.604929630293;5301.973490132525;5933.169356290123;5947.1079338099635;5947.256592925884;5949.46454819064;5955.106733989936;5769.596128271022;5879.8530036749;5931.703414829284;5945.940540594582;5956.7319470623925;5566.666000040011;5569.387367389584;5574.86062848428;5578.804741834057;5605.635633683797;6060.8172347023565;6074;6081.908771368433;6085.208922840003;6092.086187071975;5718.628289161191;5722.2561067061015;5781.971090144522;5851.6781577012825;5860.736266868002;5917.733701983421;5927.4665280125;5929.762809487658;5936.37668044849;5941.70291485424;5872.530197584183;5880.852978675567;5882.294124704978;5890;5892.086726557391;5784.1034639630925;5842.211301474246;5858.209141765807;5866.090755932837;5916.674582897982;4470.9105817883465;4479.17135329965;4483.618892394118;4485.349624304523;4507.030988337523;4013.3979903014783;4053.473048503735;4065.0447144920918;4083.244599749056;4092.3043082676018;5396.91904621431;5538.0585300499015;5604.6917419541505;5619.241402410622;5631.802886898939;5901.7639294427745;5925.140854576062;5949.077892926603;5955.493783028491;5963.19496867926;5417.187421886749;5575.0522411190195;5584.525315348241;5590.608657393944;5599.244102046172;5054.848354549369;5092.668976516515;5095.694258344512;5109.718965456861;5132.9743351283005;5984.760609575568;6033.185519954838;6038.365971573009;6040.969795150996;6057.151998720183;5764.106563482667;5818.418158184148;5866.6480011199465;5868.882622347614;5871.6770577618645;6000.519958403404;6064.545159113172;6068.6965651716355;6070.726817293144;6105.511559075175;5682.346530149086;5718.199452076629;5737.139429085671;5740.741666624928;5803.506701930383;5823.563232757476;5916.3492015877355;5922.555808314308;5923.7926672566255;5961.850953726192;5812.157237200667;5812.505936995402;5815.738291776965;5816.767329306949;5824.097264923944;5767.163761254678;5795.1017592273265;5821.126830975388;5821.214136091573;5825.0388685866355;5490.176473529003;5655.688937108499;5671.17767923657;5709.229254050816;5742.310922689304;5623.803166889139;5777.422257774189;5826.067829147316;5853.64878107315;5862.237909071793;5596.636218645938;5634.718264086861;5635.88728225425;5646.181303711021;5664.065429204135 16:41:07 INFO - PROCESS | 25058 | |1;ext.html;509.95713765349853;537.8951104534616;555.5111501878347;568.2442351672275;577.9797707080251;31562.368752624934;32370.838145809266;39581.4062789058;40174.39738403919;40270.59729402705;42952.57047429525;43345.56654433455;43356;43371.78314108433;43445;7910.525368477881;8793;8982.281417486618;9005.459672419676;10220.74448138795;10436.895631043668;10588.894111058906;10610.522526486327;10613.363198208093;10613.363198208093;10556.472176391188;10644.148468122532;10678.733031674232;10681.198910081735;10683.198760092986;10554.419506927154;10631.096356809681;10647.840282395731;10653.414062226575;10660.253782235246;10452.372857628567;10577.947110264477;10599.735006624818;10610.840837387444;11022.393768342738;44874.32688509675;45396.09207815858;45422;45440.3183952241;45444.318335225;3726.9440958385644;3888.202918401721;3959.8812035638975;4246.384274280243;4529.320601909707;33958.660413395795;34073.48889766655;34092.31815363704;34157.48763768545;35692.82153589215;4269.167512335096;4366.323219900921;4386.934195987063;4420.182266280716;4459.799309031101;311666;311749;313620;314196;316749;45729.771351143696;66191.33808661852;66765.6661716698;67008;67019;44899;45096.54903450989;45099.774501127285;45121.77439112784;45139;15361.769573456408;16391.590210244838;16602;16613.00321980685;16633.251503682364;11674.474648640831;12979.091463597646;13014.804777928339;13059.673508162372;13116;14916.552503424915;15250.313735881911;15278.31247593861;15297.770533442008;15416.845831541765;5937.664025594293;6089.1779609753;6202.937970620326;6261.154744109578;6269.467095296951;1060.7401186709305;1070.4701172919454;1077.9946100269606;1105.2639439999564;1116.6929094498914;30777.846110769304;31113.688863111533;31867;34409.82795086008;36264.15056899909;1171.5372427890936;1201.531402752927;1208.3897631695938;1254.9372531373394;1256.3718140929536;15959.44141955026;16002.439914602934;16166.515004549883;16290.185490725416;16507.422240221535;411125;423907;424173;424305;424461;62257;63641;63700.68149659315;63702.68148659227;63713;1389.7081612861411;1433.3908089062106;1512.3421311729212;1540.15291589623;1557.4938145102888;30059.549106762977;30401.172266331803;30431.695683042886;32498.52533917165;33064.33871322512;48973.75513122412;49148.26277605767;49542.75228623834;49556.25665614947;49573.25640115474;261847;262670;263107;263501;292499;34193.31613367768;34510.309793803484;34805.65194348125;34912.47631285583;34928;44048;45630.54369456263;46027.76986115048;46159;46532.30201547047;37817.432738508396;38822;38936.610633893295;39022.4146637795;39262;37190.8140459296;37751.81124094362;38434.42348364833;38548.42177367285;38612;37514.624853752204;38328.61671383362;38352.23295534018;38432.231355372176;38844.41733373945;32883.177920552174;34762.82618586992;34767.65232347745;34855.82572087123;35061.64938350686;29928;31221.53167702441;31238;31319.120054298684;31386.52920206153 16:41:07 INFO - PROCESS | 25058 | |2;jquery.html;376.46165982644806;384.73645552796336;389.445040816836;394.66847847807855;403.7799399327366;17249.82750172498;18619.906900465478;19106.90446547767;19206.903965480153;19215.711764323547;17444.47666570002;17707.1146442678;17734.113294335297;17980.64038719225;17986.82013179871;5569.916451253224;5753.309602847643;5778.046622307335;5786.942130578704;5787.4212578742;4311.051568654891;6030.246219222598;6324.683765811691;6349.174607301067;6359.395857393541;6089.421504957022;6272.247330320368;6289.716962736665;6325;6326.272478664943;6241.594296370721;6253.968730156365;6263.874722505524;6287.559870809068;6289.748410063592;3908.1988192420486;5376.946230537723;5583.664980101207;5592.356878958931;5595.18869763882;20103.095360708805;20106.497337566678;20148.19407223724;20377.286794962107;20415.081321340575;2386.642003699442;2403.0868270057267;2411.2645643078854;2425.55127301448;2477.380654836291;12787.808182877265;13040.794791645916;13335.199888006751;13541.52604658842;14102.92948535261;1750.5098572399747;1765.9028753418556;1810.8189181081918;1834.4221570205343;1933.1397528100001;66437.33562664408;67753.66123169402;67791.66104169497;68087;68666;9883.851742223873;10412;10530.578776848994;10943.616973406051;10991.120710343153;14477.276136193359;14505.709885802225;14606.707865842624;14606.780898286534;14624.19566923808;7796.8050798729355;8123.66929558878;8191.8771218431775;8326.333893288522;8400.915990840136;8163.7142700005215;8193.754187374388;8213.95893020531;8226.917730822735;8232.259096681328;4674.392328997209;4688.624910007191;4712.976435117871;4729.69256998294;4780.760961951889;1787.7318402239769;1862.5622978600018;1901.1444849817638;1918.9136488858035;1971.3691618682171;903.8327909336793;991.4992928571025;1031.5873650539845;1031.6389263757624;1046.5029111172285;16015.519534413987;16176;16443.342266309213;16756.58108547296;16832.663346733243;1005.7385079879284;1013.8138378097643;1042.3485321673954;1062.16089289462;1065.1106326217541;9821.607135714492;9849.21206303494;9971.102600765966;10039.949800250952;10277;424612;427412;433037;434058;438553;74365;77488;77779.61110194527;78431;79559.60220198861;1054.4095306628312;1056.3767377247461;1065.781514789482;1072.5441687282873;1130.10156925243;15128.54614361571;15761.211939402754;15852.365905363657;15945;15996.120213388376;34742;34821.651783482856;34895.12762180966;35316.47025294571;35583.644163558034;47028.29457558071;50469.74765126151;51218.74390628023;51320;51338.74330628323;8010.679572817256;8052.315553178046;8101.513909165469;8189.795255118432;8253.711120110767;11428.828567571327;11756.58851940178;11998.340091295062;12046;12242.204256723284;10278.897211028094;10525.000124988113;10532.157427405942;10657.786844263226;10742.89257107419;10082.495875206063;10335.431551264752;10408.375497470177;10673.146148308271;10870.34777913296;10445.634402795866;10612.840807387742;10638.14894808429;10845.620403286162;10950.780984380108;7831.295183433518;7844.450888437755;7859;7875.251851074138;8047.919520804951;8401.579921004048;9879.259055570717;10409.791804163722;10566.154707623218;10634.946825265824 16:41:07 INFO - PROCESS | 25058 | |3;mootools.html;1417.1922004457451;1562.3672412672865;1570.9921450392746;1812.8096549862264;1905.7522522072138;8342.207490288429;8500.659973601048;8544.871826922594;8554.05905350411;8562.529060901648;8288;8439.11389304122;8444.155584441552;8447.704330348439;8454.78863028423;2131.8720876747443;2188.4528867783056;2386.59427897257;2432.075811191745;2453.9386515337083;2405.4226985523437;2422.382292515406;2422.842515236504;2423.9515209695796;2424.0303878448585;2354.8469349492316;2355.128602417108;2393.796527295182;2466.3464181991785;2467.0255249176566;2417.504411595619;2435.8538487690707;2439.0731522021697;2446.7920226780743;2484.7266800651914;2435.391152211947;2448.595981663041;2460.2496238647204;2461.679981602398;2461.9753802462105;8546.70086546974;8624.4394114383;8625.870611940825;8628.956855215747;8634.438761480484;5306.204069389622;5395.10980688186;5402.486763757437;5409.702466364349;5421.647592906488;3380.2394461246267;3434.4504879219453;3438.415469370213;3481.617022127564;3491.598466176397;1107.6898468428853;1110.1174566219875;1112.0380870546999;1117.6032508459461;1122.5846436818347;12230.571929982498;12232.204906681038;12237.938810305981;12286.262824230575;12350.320732359716;4749.715017098985;4835.34599189637;4853.150698627726;4853.466118726938;4863;10224.897751022543;10288.434136122585;10303.948480257552;10307.536160872778;10323;5397.190421436738;5401.378841433207;5403.837884863382;5407.188921661782;5411.540019098421;4328.761918094472;4804.903901921942;4879.438864530624;4879.975600122048;4934.703917764946;3898.590647981921;3941.684665226775;3998.740081894726;4018.0557568971267;4024.2353952748886;1291.373683763374;1304.5434098065791;1307.8888294495075;1316.73665266947;1319.0502837956656;1411.56947131126;1429.2353590828857;1438.5252866554013;1462.0131411297332;1477.7561702319213;8292.12932642076;8322.875156872651;8337;8337.833243335099;8368.288695460955;546.7097649547065;1248.263524520519;1301.4403806363355;1303.4330066420948;1311.7901135818224;6187.226596675416;6214.658193799294;6287.371262873768;6317.178766760292;6318.273398559132;10066.245031622657;10489.790204196026;10514.369137851754;10519.94740026295;10524.526396312185;10080.546375413123;10197.388156710622;10210.693679189637;10344.431056291825;10401.58393664245;8214.424990250625;8405.873911891327;8455.450395724381;8472.068072512018;8488.236058754619;7808.88286675689;7862.01724784402;7866.646000930086;7883.881741773993;7965.641546130322;9538.523073846141;9562.569684364082;9580.281478888972;9663.985281545618;9726.173275271682;9651.806963860823;9920.454375009444;10025.197984161105;10189.745256368353;10203.234757393373;6155.107509411021;6954.408875245661;7168.354848063491;7424.888626670496;7535;8126.5936703163425;8133.79665508367;8148.3888708348295;8222.218889205516;8237.546934918637;7068.29317068289;7235.819104522429;7269.600171990592;7341.6696248670005;7379.003834482276;7228.9277107230355;7242.96378518104;7333.230010848784;7379.778606641809;7394.593297368697;7483.962580187064;7487.438442116754;7532.171461139161;7542.132654744774;7546.396288297033;6920.826979325557;6939.583624982517;6951.582905025714;6956.860862782817;6965.442764578923;6838.589684618939;7063.82340441493;7066.893996590158;7097.645117744195;7105.75129870452 16:41:07 INFO - PROCESS | 25058 | |4;prototype.html;364.20784793075063;369.859453407705;369.90382500549885;370.5386793442165;374.7077279721818;6004.658183308507;6091.512678985681;6098.2072330597075;6123.142760013596;6132.26412830461;6004.639721616706;6012.639241645505;6014.037753959367;6017.819465416033;6023.728932198051;4453.109378124372;4573.314002899575;4657.953420465786;4692.483826779052;4710.434747830265;4644.489106198315;4666.2067448533835;4678.602318802906;4681.274402467623;4687.437507499105;4666.859994200179;4688.413948256468;4692.788824502905;4706.435227772672;4720.409948756405;4492.0791237796175;4558.863234102965;4627.768611569408;4636.976815115903;4637.976810115962;4117.053077792095;4132.194222126686;4132.442120313779;4138.151678905817;4145.357469592218;5703.800366987136;5708.971455142698;5719.370869204384;5719.456651618089;5726.856828579277;5472.151816468414;5487;5502.312210973629;5503.3395992481155;5503.642263252916;6374.075759014917;6381.329960354189;6382.712777925005;6383.744650213986;6388.776392826276;4362.105768317488;4514.909701805978;4522.796474158671;4524.932126018112;4628.606568441686;6588.637624930627;6658.4673226141795;6663.200415950117;6669;6673.165854268216;4624.815007399667;4629.560191781776;4632.814687412533;4636.44362676481;4638.0955713636195;4684.8360307389075;4700.153972284953;4704.5765881070865;4704.788284527204;4710.69380490267;5394.78420863169;5405.7567409466665;5410.053240682943;5411.350637923474;5414.1321244170695;6292.402221788922;6422.197225346832;6431.099646049557;6447.25856526496;6461.418472337418;1634.5259874636222;1638.1563494800187;1647.5798671338732;1649.1424459281106;1650.1501726610804;1031.7214352125034;1085.2728671789919;1088.9455527223606;1098.2861140258897;1116.4194618798178;6062.939370606326;6145;6159.045347971071;6159.076138579159;6170.136180934673;6541.116949211891;6552.410283074546;6563.573367731082;6565.934340656628;6574.901376479356;6098.756049758049;6141.96929015361;6142.04798256271;6150;6151.66165860873;3511.3328467591077;3548.4854696068924;3549.7337699672626;3550.0592343029116;3552.626974167727;6551.181102362205;6678.031685405589;6752.426043786333;6759.087523184406;6760.797176084725;6662.966685166543;6730.865382692319;6765.323467653294;6766.15423072116;6773.390394864486;6710;6713.932860671331;6715.791157591582;6718.798436046926;6728.697208625624;6528.477721782341;6532.281449040506;6540.411362977355;6545.14913061318;6545.639989800607;6293.874122517615;6382.96808515973;6402.647854368054;6429.421352078335;6442.742290308523;6688.565243259172;6716.227633822173;6719.160104986877;6722.899156512754;6726.461883049246;4596.885077872947;4607.723536587815;4608.815647374067;4617.399738034034;4621.075784842978;6542.509311801538;6547.345265473415;6556.770513032021;6559.573627714183;6568.8357791055605;6234.594751341148;6303.684815759286;6362.204724409449;6386.265579458422;6386.297507274103;6406.487481001415;6455.193100862392;6456.483481321577;6460.741570337133;6461.353864613501;6203.8138855834395;6225.719842607003;6231.2522497300615;6240.344763799736;6244.094606282155;6347.68261586928;6356.809295721136;6364.681765911593;6376.93623063782;6377.681115944277;6069.666168360783;6108.75564977396;6252.406021427957;6258.874822503433;6304.968475157778 16:41:07 INFO - PROCESS | 25058 | |5;yui.html;743.591024936285;744.590475238619;762.9465937384385;866.2463656618743;874.3267683883412;14620.195889226088;14802.777958330607;14807.33366998485;14808.11151330921;14819.407223711052;14186.574402767908;14882.553523394288;15062.924685376585;15064.32210550525;15082.245887705625;765.9578723170223;893.7899593595516;899.1458114790942;919.3794188922484;923.2521657457447;901.8151278987792;905.9728208153733;907.0657223060258;908.1644886704248;908.4095338030301;944.6835310171101;946.607158029417;946.6781294359917;946.9905300946971;947.5688561704443;802.0495712580581;944.2257348973844;967.061949908591;967.3953778888194;969.5976169889487;706.6043015911106;708.0512113767576;709.971601135954;710.5843081797154;711.3349018667562;14911;14996.175210363426;15064.096154230781;15064.849351506455;15084.924575377054;13863.168209907439;14066.578002659937;14067.577972660734;14115.929420352833;14578.708425831424;10806.405647689375;10895.945520272428;10993.890061099366;11054.834177487344;11208.15938804593;3794.886153415402;3801.1637439763485;3804;3837.884863454101;3874.1670540833857;51487.74256128733;51582.48417515814;53109;53403.46596534024;53451.999999999614;10865.891341086646;11237.60668376603;11366;11560.075193984461;11624.53501859933;19505.804941950682;19552.120154593078;19714.70427943582;19878.503037423892;19934.30229941945;8280.958595206985;8287.088420273765;8326.791830204293;8395.076541580422;8397.118302578263;4213.705040647186;4276.935845962313;4283.7429754214845;4293.527711951683;4337.50118736343;3456.913577160591;3463.7229021678204;3476.687098161127;3479.791212527206;3480.3387356402204;608.60744819592;624.7219987105785;647.5240698086902;657.9342065793478;694.4201591671011;645.1580687203151;653.5882394091692;654.2835595023441;662.9237637671633;663.2405895249912;8213.425060245725;8314.334853211729;8355.122712115262;8363.330933525303;8608.655653773903;701.6632016631943;708.7094291340628;713.2368365848596;722.2019668266595;734.6106563521342;3863.768173909574;3949.5260568731937;4019.979900100481;4029.2143032108456;4099.938500922489;56873.43126568764;58519.70740146272;58870.41129588735;59010;59205.703971480725;52824.73587632114;53413.465865341626;53530.732346338795;53651.73174134104;54159;46584.83537911512;47329.76335118302;47653.04693906102;47674;48611;8034.919650803651;8098.109207987234;8213.301869341172;8219.219174178443;8270.172982701682;35775.64224357827;36726.44910326401;36938;37495.062623434635;37767.24465510729;41294;41719.58280417157;43759.78120109379;45646.54353456556;46080;10757.1932105094;10798.784024319313;10804.567817287221;10974.945125274322;11258.21192516516;11336.659900203007;11632.127590430582;11659.53361865516;11664.825027624762;11670.358130302915;10386.792264154827;10648.946755266485;11788.76422471563;12259.203151795105;12285;11465.885341146815;11566.537338506365;11630.185886987829;11768.529258829893;11931.642050738144;11362.14783891228;11571.594994175164;11746.471408786454;11989.100817438553;12393.194442361219;9986;10290.3825770454;10304.742381440225;10305.845412318971;10497.632582859564;9910.504474776088;10132.594696212069;10148.746281343025;10176.542055607368;10317.380957142595 16:41:07 INFO - PROCESS | 25058 | __end_tp_report 16:41:07 INFO - PROCESS | 25058 | __start_cc_report 16:41:07 INFO - PROCESS | 25058 | _x_x_mozilla_cycle_collect,718 16:41:07 INFO - PROCESS | 25058 | __end_cc_report 16:41:07 INFO - PROCESS | 25058 | __startTimestamp1461022867587__endTimestamp 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | ------- Summary: start ------- 16:41:07 INFO - PROCESS | 25058 | Number of tests: 6 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | [#0] dojo.html Cycles:165 Average:5475.34 Median:5664.07 stddev:598.10 (10.6%) stddev-sans-first:575.74 16:41:07 INFO - PROCESS | 25058 | Values: 3329.2 3365.4 3375.6 3385.1 3402.1 5436.0 5471.0 5495.7 5516.1 5539.5 5486.0 5526.9 5531.0 5532.3 5542.3 4856.1 4992.5 5030.8 5109.5 5116.3 4940.2 5023.8 5026.3 5030.0 5032.2 4977.0 5025.9 5038.6 5043.3 5051.5 4948.1 5036.1 5090.0 5093.8 5097.8 4867.5 5006.6 5023.1 5038.5 5076.8 5193.7 5263.2 5264.2 5267.6 5302.0 5933.2 5947.1 5947.3 5949.5 5955.1 5769.6 5879.9 5931.7 5945.9 5956.7 5566.7 5569.4 5574.9 5578.8 5605.6 6060.8 6074.0 6081.9 6085.2 6092.1 5718.6 5722.3 5782.0 5851.7 5860.7 5917.7 5927.5 5929.8 5936.4 5941.7 5872.5 5880.9 5882.3 5890.0 5892.1 5784.1 5842.2 5858.2 5866.1 5916.7 4470.9 4479.2 4483.6 4485.3 4507.0 4013.4 4053.5 4065.0 4083.2 4092.3 5396.9 5538.1 5604.7 5619.2 5631.8 5901.8 5925.1 5949.1 5955.5 5963.2 5417.2 5575.1 5584.5 5590.6 5599.2 5054.8 5092.7 5095.7 5109.7 5133.0 5984.8 6033.2 6038.4 6041.0 6057.2 5764.1 5818.4 5866.6 5868.9 5871.7 6000.5 6064.5 6068.7 6070.7 6105.5 5682.3 5718.2 5737.1 5740.7 5803.5 5823.6 5916.3 5922.6 5923.8 5961.9 5812.2 5812.5 5815.7 5816.8 5824.1 5767.2 5795.1 5821.1 5821.2 5825.0 5490.2 5655.7 5671.2 5709.2 5742.3 5623.8 5777.4 5826.1 5853.6 5862.2 5596.6 5634.7 5635.9 5646.2 5664.1 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | [#1] ext.html Cycles:180 Average:51116.92 Median:34786.65 stddev:89508.35 (257.3%) stddev-sans-first:89678.79 16:41:07 INFO - PROCESS | 25058 | Values: 510.0 537.9 555.5 568.2 578.0 31562.4 32370.8 39581.4 40174.4 40270.6 42952.6 43345.6 43356.0 43371.8 43445.0 7910.5 8793.0 8982.3 9005.5 10220.7 10436.9 10588.9 10610.5 10613.4 10613.4 10556.5 10644.1 10678.7 10681.2 10683.2 10554.4 10631.1 10647.8 10653.4 10660.3 10452.4 10577.9 10599.7 10610.8 11022.4 44874.3 45396.1 45422.0 45440.3 45444.3 3726.9 3888.2 3959.9 4246.4 4529.3 33958.7 34073.5 34092.3 34157.5 35692.8 4269.2 4366.3 4386.9 4420.2 4459.8 311666.0 311749.0 313620.0 314196.0 316749.0 45729.8 66191.3 66765.7 67008.0 67019.0 44899.0 45096.5 45099.8 45121.8 45139.0 15361.8 16391.6 16602.0 16613.0 16633.3 11674.5 12979.1 13014.8 13059.7 13116.0 14916.6 15250.3 15278.3 15297.8 15416.8 5937.7 6089.2 6202.9 6261.2 6269.5 1060.7 1070.5 1078.0 1105.3 1116.7 30777.8 31113.7 31867.0 34409.8 36264.2 1171.5 1201.5 1208.4 1254.9 1256.4 15959.4 16002.4 16166.5 16290.2 16507.4 411125.0 423907.0 424173.0 424305.0 424461.0 62257.0 63641.0 63700.7 63702.7 63713.0 1389.7 1433.4 1512.3 1540.2 1557.5 30059.5 30401.2 30431.7 32498.5 33064.3 48973.8 49148.3 49542.8 49556.3 49573.3 261847.0 262670.0 263107.0 263501.0 292499.0 34193.3 34510.3 34805.7 34912.5 34928.0 44048.0 45630.5 46027.8 46159.0 46532.3 37817.4 38822.0 38936.6 39022.4 39262.0 37190.8 37751.8 38434.4 38548.4 38612.0 37514.6 38328.6 38352.2 38432.2 38844.4 32883.2 34762.8 34767.7 34855.8 35061.6 29928.0 31221.5 31238.0 31319.1 31386.5 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | [#2] jquery.html Cycles:180 Average:25810.11 Median:2451.47 stddev:70883.44 (2891.5%) stddev-sans-first:71056.56 16:41:07 INFO - PROCESS | 25058 | Values: 376.5 384.7 389.4 394.7 403.8 17249.8 18619.9 19106.9 19206.9 19215.7 17444.5 17707.1 17734.1 17980.6 17986.8 5569.9 5753.3 5778.0 5786.9 5787.4 4311.1 6030.2 6324.7 6349.2 6359.4 6089.4 6272.2 6289.7 6325.0 6326.3 6241.6 6254.0 6263.9 6287.6 6289.7 3908.2 5376.9 5583.7 5592.4 5595.2 20103.1 20106.5 20148.2 20377.3 20415.1 2386.6 2403.1 2411.3 2425.6 2477.4 12787.8 13040.8 13335.2 13541.5 14102.9 1750.5 1765.9 1810.8 1834.4 1933.1 66437.3 67753.7 67791.7 68087.0 68666.0 9883.9 10412.0 10530.6 10943.6 10991.1 14477.3 14505.7 14606.7 14606.8 14624.2 7796.8 8123.7 8191.9 8326.3 8400.9 8163.7 8193.8 8214.0 8226.9 8232.3 4674.4 4688.6 4713.0 4729.7 4780.8 1787.7 1862.6 1901.1 1918.9 1971.4 903.8 991.5 1031.6 1031.6 1046.5 16015.5 16176.0 16443.3 16756.6 16832.7 1005.7 1013.8 1042.3 1062.2 1065.1 9821.6 9849.2 9971.1 10039.9 10277.0 424612.0 427412.0 433037.0 434058.0 438553.0 74365.0 77488.0 77779.6 78431.0 79559.6 1054.4 1056.4 1065.8 1072.5 1130.1 15128.5 15761.2 15852.4 15945.0 15996.1 34742.0 34821.7 34895.1 35316.5 35583.6 47028.3 50469.7 51218.7 51320.0 51338.7 8010.7 8052.3 8101.5 8189.8 8253.7 11428.8 11756.6 11998.3 12046.0 12242.2 10278.9 10525.0 10532.2 10657.8 10742.9 10082.5 10335.4 10408.4 10673.1 10870.3 10445.6 10612.8 10638.1 10845.6 10950.8 7831.3 7844.5 7859.0 7875.3 8047.9 8401.6 9879.3 10409.8 10566.2 10634.9 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | [#3] mootools.html Cycles:180 Average:6029.43 Median:4907.34 stddev:3170.68 (64.6%) stddev-sans-first:3160.62 16:41:07 INFO - PROCESS | 25058 | Values: 1417.2 1562.4 1571.0 1812.8 1905.8 8342.2 8500.7 8544.9 8554.1 8562.5 8288.0 8439.1 8444.2 8447.7 8454.8 2131.9 2188.5 2386.6 2432.1 2453.9 2405.4 2422.4 2422.8 2424.0 2424.0 2354.8 2355.1 2393.8 2466.3 2467.0 2417.5 2435.9 2439.1 2446.8 2484.7 2435.4 2448.6 2460.2 2461.7 2462.0 8546.7 8624.4 8625.9 8629.0 8634.4 5306.2 5395.1 5402.5 5409.7 5421.6 3380.2 3434.5 3438.4 3481.6 3491.6 1107.7 1110.1 1112.0 1117.6 1122.6 12230.6 12232.2 12237.9 12286.3 12350.3 4749.7 4835.3 4853.2 4853.5 4863.0 10224.9 10288.4 10303.9 10307.5 10323.0 5397.2 5401.4 5403.8 5407.2 5411.5 4328.8 4804.9 4879.4 4880.0 4934.7 3898.6 3941.7 3998.7 4018.1 4024.2 1291.4 1304.5 1307.9 1316.7 1319.1 1411.6 1429.2 1438.5 1462.0 1477.8 8292.1 8322.9 8337.0 8337.8 8368.3 546.7 1248.3 1301.4 1303.4 1311.8 6187.2 6214.7 6287.4 6317.2 6318.3 10066.2 10489.8 10514.4 10519.9 10524.5 10080.5 10197.4 10210.7 10344.4 10401.6 8214.4 8405.9 8455.5 8472.1 8488.2 7808.9 7862.0 7866.6 7883.9 7965.6 9538.5 9562.6 9580.3 9664.0 9726.2 9651.8 9920.5 10025.2 10189.7 10203.2 6155.1 6954.4 7168.4 7424.9 7535.0 8126.6 8133.8 8148.4 8222.2 8237.5 7068.3 7235.8 7269.6 7341.7 7379.0 7228.9 7243.0 7333.2 7379.8 7394.6 7484.0 7487.4 7532.2 7542.1 7546.4 6920.8 6939.6 6951.6 6956.9 6965.4 6838.6 7063.8 7066.9 7097.6 7105.8 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | [#4] prototype.html Cycles:180 Average:5353.73 Median:6103.76 stddev:1581.96 (25.9%) stddev-sans-first:1541.43 16:41:07 INFO - PROCESS | 25058 | Values: 364.2 369.9 369.9 370.5 374.7 6004.7 6091.5 6098.2 6123.1 6132.3 6004.6 6012.6 6014.0 6017.8 6023.7 4453.1 4573.3 4658.0 4692.5 4710.4 4644.5 4666.2 4678.6 4681.3 4687.4 4666.9 4688.4 4692.8 4706.4 4720.4 4492.1 4558.9 4627.8 4637.0 4638.0 4117.1 4132.2 4132.4 4138.2 4145.4 5703.8 5709.0 5719.4 5719.5 5726.9 5472.2 5487.0 5502.3 5503.3 5503.6 6374.1 6381.3 6382.7 6383.7 6388.8 4362.1 4514.9 4522.8 4524.9 4628.6 6588.6 6658.5 6663.2 6669.0 6673.2 4624.8 4629.6 4632.8 4636.4 4638.1 4684.8 4700.2 4704.6 4704.8 4710.7 5394.8 5405.8 5410.1 5411.4 5414.1 6292.4 6422.2 6431.1 6447.3 6461.4 1634.5 1638.2 1647.6 1649.1 1650.2 1031.7 1085.3 1088.9 1098.3 1116.4 6062.9 6145.0 6159.0 6159.1 6170.1 6541.1 6552.4 6563.6 6565.9 6574.9 6098.8 6142.0 6142.0 6150.0 6151.7 3511.3 3548.5 3549.7 3550.1 3552.6 6551.2 6678.0 6752.4 6759.1 6760.8 6663.0 6730.9 6765.3 6766.2 6773.4 6710.0 6713.9 6715.8 6718.8 6728.7 6528.5 6532.3 6540.4 6545.1 6545.6 6293.9 6383.0 6402.6 6429.4 6442.7 6688.6 6716.2 6719.2 6722.9 6726.5 4596.9 4607.7 4608.8 4617.4 4621.1 6542.5 6547.3 6556.8 6559.6 6568.8 6234.6 6303.7 6362.2 6386.3 6386.3 6406.5 6455.2 6456.5 6460.7 6461.4 6203.8 6225.7 6231.3 6240.3 6244.1 6347.7 6356.8 6364.7 6376.9 6377.7 6069.7 6108.8 6252.4 6258.9 6305.0 16:41:07 INFO - PROCESS | 25058 | 16:41:07 INFO - PROCESS | 25058 | [#5] yui.html Cycles:180 Average:14421.56 Median:4245.32 stddev:16507.80 (388.8%) stddev-sans-first:16522.15 16:41:07 INFO - PROCESS | 25058 | Values: 743.6 744.6 762.9 866.2 874.3 14620.2 14802.8 14807.3 14808.1 14819.4 14186.6 14882.6 15062.9 15064.3 15082.2 766.0 893.8 899.1 919.4 923.3 901.8 906.0 907.1 908.2 908.4 944.7 946.6 946.7 947.0 947.6 802.0 944.2 967.1 967.4 969.6 706.6 708.1 710.0 710.6 711.3 14911.0 14996.2 15064.1 15064.8 15084.9 13863.2 14066.6 14067.6 14115.9 14578.7 10806.4 10895.9 10993.9 11054.8 11208.2 3794.9 3801.2 3804.0 3837.9 3874.2 51487.7 51582.5 53109.0 53403.5 53452.0 10865.9 11237.6 11366.0 11560.1 11624.5 19505.8 19552.1 19714.7 19878.5 19934.3 8281.0 8287.1 8326.8 8395.1 8397.1 4213.7 4276.9 4283.7 4293.5 4337.5 3456.9 3463.7 3476.7 3479.8 3480.3 608.6 624.7 647.5 657.9 694.4 645.2 653.6 654.3 662.9 663.2 8213.4 8314.3 8355.1 8363.3 8608.7 701.7 708.7 713.2 722.2 734.6 3863.8 3949.5 4020.0 4029.2 4099.9 56873.4 58519.7 58870.4 59010.0 59205.7 52824.7 53413.5 53530.7 53651.7 54159.0 46584.8 47329.8 47653.0 47674.0 48611.0 8034.9 8098.1 8213.3 8219.2 8270.2 35775.6 36726.4 36938.0 37495.1 37767.2 41294.0 41719.6 43759.8 45646.5 46080.0 10757.2 10798.8 10804.6 10974.9 11258.2 11336.7 11632.1 11659.5 11664.8 11670.4 10386.8 10648.9 11788.8 12259.2 12285.0 11465.9 11566.5 11630.2 11768.5 11931.6 11362.1 11571.6 11746.5 11989.1 12393.2 9986.0 10290.4 10304.7 10305.8 10497.6 9910.5 10132.6 10148.7 10176.5 10317.4 16:41:07 INFO - PROCESS | 25058 | -------- Summary: end -------- 16:41:07 INFO - PROCESS | 25058 | 16:41:08 INFO - TEST-INFO | 25058: exit 0 16:41:08 INFO - TEST-OK | dromaeo_css | took 1111736ms 16:41:08 INFO - TEST-START | kraken 16:41:08 INFO - operating with platform_type : linux_ 16:41:08 INFO - Initialising browser for kraken test... 16:41:08 INFO - TEST-INFO | started process 25251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp64Tb8D/profile http://localhost:56675/getInfo.html) 16:41:12 INFO - PROCESS | 25251 | __metrics Screen width/height:1600/1200 16:41:12 INFO - PROCESS | 25251 | colorDepth:24 16:41:12 INFO - PROCESS | 25251 | Browser inner width/height: 1024/697 16:41:12 INFO - PROCESS | 25251 | __metrics 16:41:13 INFO - PROCESS | 25251 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:14 INFO - TEST-INFO | 25251: exit 0 16:41:14 INFO - Browser initialized. 16:41:14 INFO - Running cycle 1/1 for kraken test... 16:41:14 INFO - TEST-INFO | started process 25339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp64Tb8D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:25 INFO - PROCESS | 25339 | RSS: Main: 140967936 16:41:25 INFO - PROCESS | 25339 | 16:41:28 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56675/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:28 INFO - PROCESS | 25339 | RSS: Main: 177401856 16:41:28 INFO - PROCESS | 25339 | 16:41:31 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56675/tests/kraken/driver.html?testName=audio-dft) 16:41:32 INFO - PROCESS | 25339 | RSS: Main: 175960064 16:41:32 INFO - PROCESS | 25339 | 16:41:34 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56675/tests/kraken/driver.html?testName=audio-fft) 16:41:35 INFO - PROCESS | 25339 | RSS: Main: 173912064 16:41:35 INFO - PROCESS | 25339 | 16:41:37 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56675/tests/kraken/driver.html?testName=audio-oscillator) 16:41:38 INFO - PROCESS | 25339 | RSS: Main: 174698496 16:41:38 INFO - PROCESS | 25339 | 16:41:40 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:40 INFO - PROCESS | 25339 | RSS: Main: 171417600 16:41:40 INFO - PROCESS | 25339 | 16:41:43 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56675/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:44 INFO - PROCESS | 25339 | RSS: Main: 171208704 16:41:44 INFO - PROCESS | 25339 | 16:41:47 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56675/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:48 INFO - PROCESS | 25339 | RSS: Main: 171417600 16:41:48 INFO - PROCESS | 25339 | 16:41:51 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56675/tests/kraken/driver.html?testName=json-parse-financial) 16:41:51 INFO - PROCESS | 25339 | RSS: Main: 171876352 16:41:51 INFO - PROCESS | 25339 | 16:41:53 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:41:53 INFO - PROCESS | 25339 | RSS: Main: 177180672 16:41:53 INFO - PROCESS | 25339 | 16:41:55 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:41:56 INFO - PROCESS | 25339 | RSS: Main: 174202880 16:41:56 INFO - PROCESS | 25339 | 16:41:58 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:58 INFO - PROCESS | 25339 | RSS: Main: 179912704 16:41:58 INFO - PROCESS | 25339 | 16:42:01 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:01 INFO - PROCESS | 25339 | RSS: Main: 187215872 16:42:01 INFO - PROCESS | 25339 | 16:42:04 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:04 INFO - PROCESS | 25339 | RSS: Main: 187899904 16:42:04 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | Cycle 1(1): loaded http://localhost:56675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56675/tests/kraken/driver.html?testName=ai-astar) 16:42:06 INFO - PROCESS | 25339 | RSS: Main: 249729024 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | __start_tp_report 16:42:06 INFO - PROCESS | 25339 | _x_x_mozilla_page_load 16:42:06 INFO - PROCESS | 25339 | _x_x_mozilla_page_load_details 16:42:06 INFO - PROCESS | 25339 | |i|pagename|runs| 16:42:06 INFO - PROCESS | 25339 | |0;ai-astar;110;111;107;109;111;109;100;110;110;109 16:42:06 INFO - PROCESS | 25339 | |1;audio-beat-detection;155;126;150;168;126;151;154;132;190;135 16:42:06 INFO - PROCESS | 25339 | |2;audio-dft;162;161;161;162;161;160;161;165;162;160 16:42:06 INFO - PROCESS | 25339 | |3;audio-fft;73;75;76;165;76;76;74;76;166;78 16:42:06 INFO - PROCESS | 25339 | |4;audio-oscillator;93;94;142;93;94;93;148;93;92;141 16:42:06 INFO - PROCESS | 25339 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;117;117;117 16:42:06 INFO - PROCESS | 25339 | |6;imaging-darkroom;146;146;147;146;146;145;146;146;146;146 16:42:06 INFO - PROCESS | 25339 | |7;imaging-desaturate;95;95;96;95;96;96;96;97;96;96 16:42:06 INFO - PROCESS | 25339 | |8;json-parse-financial;53;56;55;55;54;55;56;66;52;53 16:42:06 INFO - PROCESS | 25339 | |9;json-stringify-tinderbox;64;65;64;67;65;65;65;64;65;64 16:42:06 INFO - PROCESS | 25339 | |10;stanford-crypto-aes;77;77;84;78;79;79;78;79;79;77 16:42:06 INFO - PROCESS | 25339 | |11;stanford-crypto-ccm;117;113;112;112;119;112;112;111;111;112 16:42:06 INFO - PROCESS | 25339 | |12;stanford-crypto-pbkdf2;162;134;149;142;143;134;140;141;141;143 16:42:06 INFO - PROCESS | 25339 | |13;stanford-crypto-sha256-iterative;70;67;68;67;70;68;69;68;66;67 16:42:06 INFO - PROCESS | 25339 | __end_tp_report 16:42:06 INFO - PROCESS | 25339 | __start_cc_report 16:42:06 INFO - PROCESS | 25339 | _x_x_mozilla_cycle_collect,1061 16:42:06 INFO - PROCESS | 25339 | __end_cc_report 16:42:06 INFO - PROCESS | 25339 | __startTimestamp1461022926791__endTimestamp 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | ------- Summary: start ------- 16:42:06 INFO - PROCESS | 25339 | Number of tests: 14 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.24 (2.9%) stddev-sans-first:3.40 16:42:06 INFO - PROCESS | 25339 | Values: 110.0 111.0 107.0 109.0 111.0 109.0 100.0 110.0 110.0 109.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.50 stddev:20.14 (13.2%) stddev-sans-first:21.23 16:42:06 INFO - PROCESS | 25339 | Values: 155.0 126.0 150.0 168.0 126.0 151.0 154.0 132.0 190.0 135.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 16:42:06 INFO - PROCESS | 25339 | Values: 162.0 161.0 161.0 162.0 161.0 160.0 161.0 165.0 162.0 160.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:37.97 (50.0%) stddev-sans-first:39.54 16:42:06 INFO - PROCESS | 25339 | Values: 73.0 75.0 76.0 165.0 76.0 76.0 74.0 76.0 166.0 78.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.48 (26.3%) stddev-sans-first:25.33 16:42:06 INFO - PROCESS | 25339 | Values: 93.0 94.0 142.0 93.0 94.0 93.0 148.0 93.0 92.0 141.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:42:06 INFO - PROCESS | 25339 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 16:42:06 INFO - PROCESS | 25339 | Values: 146.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 16:42:06 INFO - PROCESS | 25339 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 97.0 96.0 96.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.92 (7.1%) stddev-sans-first:4.06 16:42:06 INFO - PROCESS | 25339 | Values: 53.0 56.0 55.0 55.0 54.0 55.0 56.0 66.0 52.0 53.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 16:42:06 INFO - PROCESS | 25339 | Values: 64.0 65.0 64.0 67.0 65.0 65.0 65.0 64.0 65.0 64.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:2.06 (2.6%) stddev-sans-first:2.09 16:42:06 INFO - PROCESS | 25339 | Values: 77.0 77.0 84.0 78.0 79.0 79.0 78.0 79.0 79.0 77.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#11] stanford-crypto-ccm Cycles:10 Average:113.10 Median:112.00 stddev:2.69 (2.4%) stddev-sans-first:2.45 16:42:06 INFO - PROCESS | 25339 | Values: 117.0 113.0 112.0 112.0 119.0 112.0 112.0 111.0 111.0 112.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:142.50 stddev:8.01 (5.6%) stddev-sans-first:4.63 16:42:06 INFO - PROCESS | 25339 | Values: 162.0 134.0 149.0 142.0 143.0 134.0 140.0 141.0 141.0 143.0 16:42:06 INFO - PROCESS | 25339 | 16:42:06 INFO - PROCESS | 25339 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.33 (2.0%) stddev-sans-first:1.20 16:42:06 INFO - PROCESS | 25339 | Values: 70.0 67.0 68.0 67.0 70.0 68.0 69.0 68.0 66.0 67.0 16:42:06 INFO - PROCESS | 25339 | -------- Summary: end -------- 16:42:06 INFO - PROCESS | 25339 | 16:42:07 INFO - TEST-INFO | 25339: exit 0 16:42:07 INFO - TEST-OK | kraken | took 59432ms 16:42:07 INFO - SUITE-END | took 1171s 16:42:07 INFO - Completed test suite (00:19:31) 16:42:07 INFO - javascript benchmark 16:42:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3329.151066478048, 3365.444701624234, 3375.6118046424654, 3385.1029477188536, 3402.0814380117367, 5436.04869147899, 5471.015217260897, 5495.6702597844105, 5516.089845175551, 5539.501444869961, 5486.0, 5526.944730552693, 5531.0, 5532.30846144232, 5542.279503664518, 4856.125897338477, 4992.475790042039, 5030.82392116276, 5109.540141387274, 5116.309298244727, 4940.1601727706375, 5023.799048038074, 5026.346574945252, 5030.044291584605, 5032.194848824189, 4976.950230497685, 5025.899482010358, 5038.647294689373, 5043.268726034723, 5051.5453609175165, 4948.1093403187415, 5036.068327359413, 5090.032893750175, 5093.847184584469, 5097.7960881564695, 4867.51324867514, 5006.5744411725045, 5023.14606516893, 5038.521340472649, 5076.796928122871, 5193.662411943212, 5263.157894736823, 5264.184051472028, 5267.604929630293, 5301.973490132525, 5933.169356290123, 5947.1079338099635, 5947.256592925884, 5949.46454819064, 5955.106733989936, 5769.596128271022, 5879.8530036749, 5931.703414829284, 5945.940540594582, 5956.7319470623925, 5566.666000040011, 5569.387367389584, 5574.86062848428, 5578.804741834057, 5605.635633683797, 6060.8172347023565, 6074.0, 6081.908771368433, 6085.208922840003, 6092.086187071975, 5718.628289161191, 5722.2561067061015, 5781.971090144522, 5851.6781577012825, 5860.736266868002, 5917.733701983421, 5927.4665280125, 5929.762809487658, 5936.37668044849, 5941.70291485424, 5872.530197584183, 5880.852978675567, 5882.294124704978, 5890.0, 5892.086726557391, 5784.1034639630925, 5842.211301474246, 5858.209141765807, 5866.090755932837, 5916.674582897982, 4470.9105817883465, 4479.17135329965, 4483.618892394118, 4485.349624304523, 4507.030988337523, 4013.3979903014783, 4053.473048503735, 4065.0447144920918, 4083.244599749056, 4092.3043082676018, 5396.91904621431, 5538.0585300499015, 5604.6917419541505, 5619.241402410622, 5631.802886898939, 5901.7639294427745, 5925.140854576062, 5949.077892926603, 5955.493783028491, 5963.19496867926, 5417.187421886749, 5575.0522411190195, 5584.525315348241, 5590.608657393944, 5599.244102046172, 5054.848354549369, 5092.668976516515, 5095.694258344512, 5109.718965456861, 5132.9743351283005, 5984.760609575568, 6033.185519954838, 6038.365971573009, 6040.969795150996, 6057.151998720183, 5764.106563482667, 5818.418158184148, 5866.6480011199465, 5868.882622347614, 5871.6770577618645, 6000.519958403404, 6064.545159113172, 6068.6965651716355, 6070.726817293144, 6105.511559075175, 5682.346530149086, 5718.199452076629, 5737.139429085671, 5740.741666624928, 5803.506701930383, 5823.563232757476, 5916.3492015877355, 5922.555808314308, 5923.7926672566255, 5961.850953726192, 5812.157237200667, 5812.505936995402, 5815.738291776965, 5816.767329306949, 5824.097264923944, 5767.163761254678, 5795.1017592273265, 5821.126830975388, 5821.214136091573, 5825.0388685866355, 5490.176473529003, 5655.688937108499, 5671.17767923657, 5709.229254050816, 5742.310922689304, 5623.803166889139, 5777.422257774189, 5826.067829147316, 5853.64878107315, 5862.237909071793, 5596.636218645938, 5634.718264086861, 5635.88728225425, 5646.181303711021, 5664.065429204135], "unit": "score", "name": "dojo.html", "value": 5437.444378933042}, {"lowerIsBetter": false, "replicates": [509.95713765349853, 537.8951104534616, 555.5111501878347, 568.2442351672275, 577.9797707080251, 31562.368752624934, 32370.838145809266, 39581.4062789058, 40174.39738403919, 40270.59729402705, 42952.57047429525, 43345.56654433455, 43356.0, 43371.78314108433, 43445.0, 7910.525368477881, 8793.0, 8982.281417486618, 9005.459672419676, 10220.74448138795, 10436.895631043668, 10588.894111058906, 10610.522526486327, 10613.363198208093, 10613.363198208093, 10556.472176391188, 10644.148468122532, 10678.733031674232, 10681.198910081735, 10683.198760092986, 10554.419506927154, 10631.096356809681, 10647.840282395731, 10653.414062226575, 10660.253782235246, 10452.372857628567, 10577.947110264477, 10599.735006624818, 10610.840837387444, 11022.393768342738, 44874.32688509675, 45396.09207815858, 45422.0, 45440.3183952241, 45444.318335225, 3726.9440958385644, 3888.202918401721, 3959.8812035638975, 4246.384274280243, 4529.320601909707, 33958.660413395795, 34073.48889766655, 34092.31815363704, 34157.48763768545, 35692.82153589215, 4269.167512335096, 4366.323219900921, 4386.934195987063, 4420.182266280716, 4459.799309031101, 311666.0, 311749.0, 313620.0, 314196.0, 316749.0, 45729.771351143696, 66191.33808661852, 66765.6661716698, 67008.0, 67019.0, 44899.0, 45096.54903450989, 45099.774501127285, 45121.77439112784, 45139.0, 15361.769573456408, 16391.590210244838, 16602.0, 16613.00321980685, 16633.251503682364, 11674.474648640831, 12979.091463597646, 13014.804777928339, 13059.673508162372, 13116.0, 14916.552503424915, 15250.313735881911, 15278.31247593861, 15297.770533442008, 15416.845831541765, 5937.664025594293, 6089.1779609753, 6202.937970620326, 6261.154744109578, 6269.467095296951, 1060.7401186709305, 1070.4701172919454, 1077.9946100269606, 1105.2639439999564, 1116.6929094498914, 30777.846110769304, 31113.688863111533, 31867.0, 34409.82795086008, 36264.15056899909, 1171.5372427890936, 1201.531402752927, 1208.3897631695938, 1254.9372531373394, 1256.3718140929536, 15959.44141955026, 16002.439914602934, 16166.515004549883, 16290.185490725416, 16507.422240221535, 411125.0, 423907.0, 424173.0, 424305.0, 424461.0, 62257.0, 63641.0, 63700.68149659315, 63702.68148659227, 63713.0, 1389.7081612861411, 1433.3908089062106, 1512.3421311729212, 1540.15291589623, 1557.4938145102888, 30059.549106762977, 30401.172266331803, 30431.695683042886, 32498.52533917165, 33064.33871322512, 48973.75513122412, 49148.26277605767, 49542.75228623834, 49556.25665614947, 49573.25640115474, 261847.0, 262670.0, 263107.0, 263501.0, 292499.0, 34193.31613367768, 34510.309793803484, 34805.65194348125, 34912.47631285583, 34928.0, 44048.0, 45630.54369456263, 46027.76986115048, 46159.0, 46532.30201547047, 37817.432738508396, 38822.0, 38936.610633893295, 39022.4146637795, 39262.0, 37190.8140459296, 37751.81124094362, 38434.42348364833, 38548.42177367285, 38612.0, 37514.624853752204, 38328.61671383362, 38352.23295534018, 38432.231355372176, 38844.41733373945, 32883.177920552174, 34762.82618586992, 34767.65232347745, 34855.82572087123, 35061.64938350686, 29928.0, 31221.53167702441, 31238.0, 31319.120054298684, 31386.52920206153], "unit": "score", "name": "ext.html", "value": 19864.37359725628}, {"lowerIsBetter": false, "replicates": [376.46165982644806, 384.73645552796336, 389.445040816836, 394.66847847807855, 403.7799399327366, 17249.82750172498, 18619.906900465478, 19106.90446547767, 19206.903965480153, 19215.711764323547, 17444.47666570002, 17707.1146442678, 17734.113294335297, 17980.64038719225, 17986.82013179871, 5569.916451253224, 5753.309602847643, 5778.046622307335, 5786.942130578704, 5787.4212578742, 4311.051568654891, 6030.246219222598, 6324.683765811691, 6349.174607301067, 6359.395857393541, 6089.421504957022, 6272.247330320368, 6289.716962736665, 6325.0, 6326.272478664943, 6241.594296370721, 6253.968730156365, 6263.874722505524, 6287.559870809068, 6289.748410063592, 3908.1988192420486, 5376.946230537723, 5583.664980101207, 5592.356878958931, 5595.18869763882, 20103.095360708805, 20106.497337566678, 20148.19407223724, 20377.286794962107, 20415.081321340575, 2386.642003699442, 2403.0868270057267, 2411.2645643078854, 2425.55127301448, 2477.380654836291, 12787.808182877265, 13040.794791645916, 13335.199888006751, 13541.52604658842, 14102.92948535261, 1750.5098572399747, 1765.9028753418556, 1810.8189181081918, 1834.4221570205343, 1933.1397528100001, 66437.33562664408, 67753.66123169402, 67791.66104169497, 68087.0, 68666.0, 9883.851742223873, 10412.0, 10530.578776848994, 10943.616973406051, 10991.120710343153, 14477.276136193359, 14505.709885802225, 14606.707865842624, 14606.780898286534, 14624.19566923808, 7796.8050798729355, 8123.66929558878, 8191.8771218431775, 8326.333893288522, 8400.915990840136, 8163.7142700005215, 8193.754187374388, 8213.95893020531, 8226.917730822735, 8232.259096681328, 4674.392328997209, 4688.624910007191, 4712.976435117871, 4729.69256998294, 4780.760961951889, 1787.7318402239769, 1862.5622978600018, 1901.1444849817638, 1918.9136488858035, 1971.3691618682171, 903.8327909336793, 991.4992928571025, 1031.5873650539845, 1031.6389263757624, 1046.5029111172285, 16015.519534413987, 16176.0, 16443.342266309213, 16756.58108547296, 16832.663346733243, 1005.7385079879284, 1013.8138378097643, 1042.3485321673954, 1062.16089289462, 1065.1106326217541, 9821.607135714492, 9849.21206303494, 9971.102600765966, 10039.949800250952, 10277.0, 424612.0, 427412.0, 433037.0, 434058.0, 438553.0, 74365.0, 77488.0, 77779.61110194527, 78431.0, 79559.60220198861, 1054.4095306628312, 1056.3767377247461, 1065.781514789482, 1072.5441687282873, 1130.10156925243, 15128.54614361571, 15761.211939402754, 15852.365905363657, 15945.0, 15996.120213388376, 34742.0, 34821.651783482856, 34895.12762180966, 35316.47025294571, 35583.644163558034, 47028.29457558071, 50469.74765126151, 51218.74390628023, 51320.0, 51338.74330628323, 8010.679572817256, 8052.315553178046, 8101.513909165469, 8189.795255118432, 8253.711120110767, 11428.828567571327, 11756.58851940178, 11998.340091295062, 12046.0, 12242.204256723284, 10278.897211028094, 10525.000124988113, 10532.157427405942, 10657.786844263226, 10742.89257107419, 10082.495875206063, 10335.431551264752, 10408.375497470177, 10673.146148308271, 10870.34777913296, 10445.634402795866, 10612.840807387742, 10638.14894808429, 10845.620403286162, 10950.780984380108, 7831.295183433518, 7844.450888437755, 7859.0, 7875.251851074138, 8047.919520804951, 8401.579921004048, 9879.259055570717, 10409.791804163722, 10566.154707623218, 10634.946825265824], "unit": "score", "name": "jquery.html", "value": 8803.267626124878}, {"lowerIsBetter": false, "replicates": [1417.1922004457451, 1562.3672412672865, 1570.9921450392746, 1812.8096549862264, 1905.7522522072138, 8342.207490288429, 8500.659973601048, 8544.871826922594, 8554.05905350411, 8562.529060901648, 8288.0, 8439.11389304122, 8444.155584441552, 8447.704330348439, 8454.78863028423, 2131.8720876747443, 2188.4528867783056, 2386.59427897257, 2432.075811191745, 2453.9386515337083, 2405.4226985523437, 2422.382292515406, 2422.842515236504, 2423.9515209695796, 2424.0303878448585, 2354.8469349492316, 2355.128602417108, 2393.796527295182, 2466.3464181991785, 2467.0255249176566, 2417.504411595619, 2435.8538487690707, 2439.0731522021697, 2446.7920226780743, 2484.7266800651914, 2435.391152211947, 2448.595981663041, 2460.2496238647204, 2461.679981602398, 2461.9753802462105, 8546.70086546974, 8624.4394114383, 8625.870611940825, 8628.956855215747, 8634.438761480484, 5306.204069389622, 5395.10980688186, 5402.486763757437, 5409.702466364349, 5421.647592906488, 3380.2394461246267, 3434.4504879219453, 3438.415469370213, 3481.617022127564, 3491.598466176397, 1107.6898468428853, 1110.1174566219875, 1112.0380870546999, 1117.6032508459461, 1122.5846436818347, 12230.571929982498, 12232.204906681038, 12237.938810305981, 12286.262824230575, 12350.320732359716, 4749.715017098985, 4835.34599189637, 4853.150698627726, 4853.466118726938, 4863.0, 10224.897751022543, 10288.434136122585, 10303.948480257552, 10307.536160872778, 10323.0, 5397.190421436738, 5401.378841433207, 5403.837884863382, 5407.188921661782, 5411.540019098421, 4328.761918094472, 4804.903901921942, 4879.438864530624, 4879.975600122048, 4934.703917764946, 3898.590647981921, 3941.684665226775, 3998.740081894726, 4018.0557568971267, 4024.2353952748886, 1291.373683763374, 1304.5434098065791, 1307.8888294495075, 1316.73665266947, 1319.0502837956656, 1411.56947131126, 1429.2353590828857, 1438.5252866554013, 1462.0131411297332, 1477.7561702319213, 8292.12932642076, 8322.875156872651, 8337.0, 8337.833243335099, 8368.288695460955, 546.7097649547065, 1248.263524520519, 1301.4403806363355, 1303.4330066420948, 1311.7901135818224, 6187.226596675416, 6214.658193799294, 6287.371262873768, 6317.178766760292, 6318.273398559132, 10066.245031622657, 10489.790204196026, 10514.369137851754, 10519.94740026295, 10524.526396312185, 10080.546375413123, 10197.388156710622, 10210.693679189637, 10344.431056291825, 10401.58393664245, 8214.424990250625, 8405.873911891327, 8455.450395724381, 8472.068072512018, 8488.236058754619, 7808.88286675689, 7862.01724784402, 7866.646000930086, 7883.881741773993, 7965.641546130322, 9538.523073846141, 9562.569684364082, 9580.281478888972, 9663.985281545618, 9726.173275271682, 9651.806963860823, 9920.454375009444, 10025.197984161105, 10189.745256368353, 10203.234757393373, 6155.107509411021, 6954.408875245661, 7168.354848063491, 7424.888626670496, 7535.0, 8126.5936703163425, 8133.79665508367, 8148.3888708348295, 8222.218889205516, 8237.546934918637, 7068.29317068289, 7235.819104522429, 7269.600171990592, 7341.6696248670005, 7379.003834482276, 7228.9277107230355, 7242.96378518104, 7333.230010848784, 7379.778606641809, 7394.593297368697, 7483.962580187064, 7487.438442116754, 7532.171461139161, 7542.132654744774, 7546.396288297033, 6920.826979325557, 6939.583624982517, 6951.582905025714, 6956.860862782817, 6965.442764578923, 6838.589684618939, 7063.82340441493, 7066.893996590158, 7097.645117744195, 7105.75129870452], "unit": "score", "name": "mootools.html", "value": 4936.6005974958825}, {"lowerIsBetter": false, "replicates": [364.20784793075063, 369.859453407705, 369.90382500549885, 370.5386793442165, 374.7077279721818, 6004.658183308507, 6091.512678985681, 6098.2072330597075, 6123.142760013596, 6132.26412830461, 6004.639721616706, 6012.639241645505, 6014.037753959367, 6017.819465416033, 6023.728932198051, 4453.109378124372, 4573.314002899575, 4657.953420465786, 4692.483826779052, 4710.434747830265, 4644.489106198315, 4666.2067448533835, 4678.602318802906, 4681.274402467623, 4687.437507499105, 4666.859994200179, 4688.413948256468, 4692.788824502905, 4706.435227772672, 4720.409948756405, 4492.0791237796175, 4558.863234102965, 4627.768611569408, 4636.976815115903, 4637.976810115962, 4117.053077792095, 4132.194222126686, 4132.442120313779, 4138.151678905817, 4145.357469592218, 5703.800366987136, 5708.971455142698, 5719.370869204384, 5719.456651618089, 5726.856828579277, 5472.151816468414, 5487.0, 5502.312210973629, 5503.3395992481155, 5503.642263252916, 6374.075759014917, 6381.329960354189, 6382.712777925005, 6383.744650213986, 6388.776392826276, 4362.105768317488, 4514.909701805978, 4522.796474158671, 4524.932126018112, 4628.606568441686, 6588.637624930627, 6658.4673226141795, 6663.200415950117, 6669.0, 6673.165854268216, 4624.815007399667, 4629.560191781776, 4632.814687412533, 4636.44362676481, 4638.0955713636195, 4684.8360307389075, 4700.153972284953, 4704.5765881070865, 4704.788284527204, 4710.69380490267, 5394.78420863169, 5405.7567409466665, 5410.053240682943, 5411.350637923474, 5414.1321244170695, 6292.402221788922, 6422.197225346832, 6431.099646049557, 6447.25856526496, 6461.418472337418, 1634.5259874636222, 1638.1563494800187, 1647.5798671338732, 1649.1424459281106, 1650.1501726610804, 1031.7214352125034, 1085.2728671789919, 1088.9455527223606, 1098.2861140258897, 1116.4194618798178, 6062.939370606326, 6145.0, 6159.045347971071, 6159.076138579159, 6170.136180934673, 6541.116949211891, 6552.410283074546, 6563.573367731082, 6565.934340656628, 6574.901376479356, 6098.756049758049, 6141.96929015361, 6142.04798256271, 6150.0, 6151.66165860873, 3511.3328467591077, 3548.4854696068924, 3549.7337699672626, 3550.0592343029116, 3552.626974167727, 6551.181102362205, 6678.031685405589, 6752.426043786333, 6759.087523184406, 6760.797176084725, 6662.966685166543, 6730.865382692319, 6765.323467653294, 6766.15423072116, 6773.390394864486, 6710.0, 6713.932860671331, 6715.791157591582, 6718.798436046926, 6728.697208625624, 6528.477721782341, 6532.281449040506, 6540.411362977355, 6545.14913061318, 6545.639989800607, 6293.874122517615, 6382.96808515973, 6402.647854368054, 6429.421352078335, 6442.742290308523, 6688.565243259172, 6716.227633822173, 6719.160104986877, 6722.899156512754, 6726.461883049246, 4596.885077872947, 4607.723536587815, 4608.815647374067, 4617.399738034034, 4621.075784842978, 6542.509311801538, 6547.345265473415, 6556.770513032021, 6559.573627714183, 6568.8357791055605, 6234.594751341148, 6303.684815759286, 6362.204724409449, 6386.265579458422, 6386.297507274103, 6406.487481001415, 6455.193100862392, 6456.483481321577, 6460.741570337133, 6461.353864613501, 6203.8138855834395, 6225.719842607003, 6231.2522497300615, 6240.344763799736, 6244.094606282155, 6347.68261586928, 6356.809295721136, 6364.681765911593, 6376.93623063782, 6377.681115944277, 6069.666168360783, 6108.75564977396, 6252.406021427957, 6258.874822503433, 6304.968475157778], "unit": "score", "name": "prototype.html", "value": 4847.515045500059}, {"lowerIsBetter": false, "replicates": [743.591024936285, 744.590475238619, 762.9465937384385, 866.2463656618743, 874.3267683883412, 14620.195889226088, 14802.777958330607, 14807.33366998485, 14808.11151330921, 14819.407223711052, 14186.574402767908, 14882.553523394288, 15062.924685376585, 15064.32210550525, 15082.245887705625, 765.9578723170223, 893.7899593595516, 899.1458114790942, 919.3794188922484, 923.2521657457447, 901.8151278987792, 905.9728208153733, 907.0657223060258, 908.1644886704248, 908.4095338030301, 944.6835310171101, 946.607158029417, 946.6781294359917, 946.9905300946971, 947.5688561704443, 802.0495712580581, 944.2257348973844, 967.061949908591, 967.3953778888194, 969.5976169889487, 706.6043015911106, 708.0512113767576, 709.971601135954, 710.5843081797154, 711.3349018667562, 14911.0, 14996.175210363426, 15064.096154230781, 15064.849351506455, 15084.924575377054, 13863.168209907439, 14066.578002659937, 14067.577972660734, 14115.929420352833, 14578.708425831424, 10806.405647689375, 10895.945520272428, 10993.890061099366, 11054.834177487344, 11208.15938804593, 3794.886153415402, 3801.1637439763485, 3804.0, 3837.884863454101, 3874.1670540833857, 51487.74256128733, 51582.48417515814, 53109.0, 53403.46596534024, 53451.999999999614, 10865.891341086646, 11237.60668376603, 11366.0, 11560.075193984461, 11624.53501859933, 19505.804941950682, 19552.120154593078, 19714.70427943582, 19878.503037423892, 19934.30229941945, 8280.958595206985, 8287.088420273765, 8326.791830204293, 8395.076541580422, 8397.118302578263, 4213.705040647186, 4276.935845962313, 4283.7429754214845, 4293.527711951683, 4337.50118736343, 3456.913577160591, 3463.7229021678204, 3476.687098161127, 3479.791212527206, 3480.3387356402204, 608.60744819592, 624.7219987105785, 647.5240698086902, 657.9342065793478, 694.4201591671011, 645.1580687203151, 653.5882394091692, 654.2835595023441, 662.9237637671633, 663.2405895249912, 8213.425060245725, 8314.334853211729, 8355.122712115262, 8363.330933525303, 8608.655653773903, 701.6632016631943, 708.7094291340628, 713.2368365848596, 722.2019668266595, 734.6106563521342, 3863.768173909574, 3949.5260568731937, 4019.979900100481, 4029.2143032108456, 4099.938500922489, 56873.43126568764, 58519.70740146272, 58870.41129588735, 59010.0, 59205.703971480725, 52824.73587632114, 53413.465865341626, 53530.732346338795, 53651.73174134104, 54159.0, 46584.83537911512, 47329.76335118302, 47653.04693906102, 47674.0, 48611.0, 8034.919650803651, 8098.109207987234, 8213.301869341172, 8219.219174178443, 8270.172982701682, 35775.64224357827, 36726.44910326401, 36938.0, 37495.062623434635, 37767.24465510729, 41294.0, 41719.58280417157, 43759.78120109379, 45646.54353456556, 46080.0, 10757.1932105094, 10798.784024319313, 10804.567817287221, 10974.945125274322, 11258.21192516516, 11336.659900203007, 11632.127590430582, 11659.53361865516, 11664.825027624762, 11670.358130302915, 10386.792264154827, 10648.946755266485, 11788.76422471563, 12259.203151795105, 12285.0, 11465.885341146815, 11566.537338506365, 11630.185886987829, 11768.529258829893, 11931.642050738144, 11362.14783891228, 11571.594994175164, 11746.471408786454, 11989.100817438553, 12393.194442361219, 9986.0, 10290.3825770454, 10304.742381440225, 10305.845412318971, 10497.632582859564, 9910.504474776088, 10132.594696212069, 10148.746281343025, 10176.542055607368, 10317.380957142595], "unit": "score", "name": "yui.html", "value": 6673.752474710562}], "name": "dromaeo_css", "value": 7304.2893489668895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 109.0, 111.0, 109.0, 100.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 150.0, 168.0, 126.0, 151.0, 154.0, 132.0, 190.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 165.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 76.0, 165.0, 76.0, 76.0, 74.0, 76.0, 166.0, 78.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 142.0, 93.0, 94.0, 93.0, 148.0, 93.0, 92.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 66.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 67.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 84.0, 78.0, 79.0, 79.0, 78.0, 79.0, 79.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [117.0, 113.0, 112.0, 112.0, 119.0, 112.0, 112.0, 111.0, 111.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.1}, {"lowerIsBetter": true, "replicates": [162.0, 134.0, 149.0, 142.0, 143.0, 134.0, 140.0, 141.0, 141.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 67.0, 70.0, 68.0, 69.0, 68.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1502.1}]} 16:42:08 INFO - Return code: 0 16:42:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:42:08 INFO - # TBPL SUCCESS # 16:42:08 INFO - Running post-action listener: _resource_record_post_action 16:42:08 INFO - Running post-run listener: _resource_record_post_run 16:42:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499191808; Read time: 16; Write time: 413260 16:42:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245198848; Read time: 0; Write time: 280708 16:42:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253964288; Read time: 16; Write time: 130068 16:42:09 INFO - Running post-run listener: _upload_blobber_files 16:42:09 INFO - Blob upload gear active. 16:42:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:42:09 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 16:42:09 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'] 16:42:09 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 16:42:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:10 INFO - (blobuploader) - INFO - Done attempting. 16:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:11 INFO - (blobuploader) - INFO - Done attempting. 16:42:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:42:11 INFO - Return code: 0 16:42:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:42:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:42:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c88a602ce8763ea585adfb9195674678ea586a5e3a7e19fc333eb56b95e49af589ee87c37714f1130faab662f139f9adc3f4233fb6e8711c2bbd726a4a953815", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6583fcdfcf8beb6937b316cdd720b3f7c6d5678dae85a1eff018a7c32e92f6ff48c38cc9eaf9233646fcf7b59950d8cc2822173615a5b4de46bc0e74db3ee57b"} 16:42:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:42:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:42:11 INFO - Contents: 16:42:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c88a602ce8763ea585adfb9195674678ea586a5e3a7e19fc333eb56b95e49af589ee87c37714f1130faab662f139f9adc3f4233fb6e8711c2bbd726a4a953815", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6583fcdfcf8beb6937b316cdd720b3f7c6d5678dae85a1eff018a7c32e92f6ff48c38cc9eaf9233646fcf7b59950d8cc2822173615a5b4de46bc0e74db3ee57b"} 16:42:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:42:11 INFO - Copying logs to upload dir... 16:42:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:42:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.397045 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-18 16:42:10.981593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:42:10.985489) ========= 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-1461021703.290274-1579861013 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/c88a602ce8763ea585adfb9195674678ea586a5e3a7e19fc333eb56b95e49af589ee87c37714f1130faab662f139f9adc3f4233fb6e8711c2bbd726a4a953815", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6583fcdfcf8beb6937b316cdd720b3f7c6d5678dae85a1eff018a7c32e92f6ff48c38cc9eaf9233646fcf7b59950d8cc2822173615a5b4de46bc0e74db3ee57b"} build_url:https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/LLAJ4GpLT_m44a3EQbmnow/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/c88a602ce8763ea585adfb9195674678ea586a5e3a7e19fc333eb56b95e49af589ee87c37714f1130faab662f139f9adc3f4233fb6e8711c2bbd726a4a953815", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6583fcdfcf8beb6937b316cdd720b3f7c6d5678dae85a1eff018a7c32e92f6ff48c38cc9eaf9233646fcf7b59950d8cc2822173615a5b4de46bc0e74db3ee57b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:42:11.009549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:42:11.009845) ========= 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-1461021703.290274-1579861013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:42:11.094485) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:42:11.094852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:42:11.095136) ========= ========= Total master_lag: 0.17 =========