builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1463069193.54 results: success (0) buildid: 20160512061943 builduid: 5f55196abfaf45eb8d0a191876533746 revision: fca62ad9c45ca847ac004a2b16807a63763e5c29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.536876) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.537908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.538227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.558810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.559235) ========= 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=62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 09:06:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-05-12 09:06:34 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.707559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.707906) ========= 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=62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017235 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.759664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:33.760037) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fca62ad9c45ca847ac004a2b16807a63763e5c29 --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 fca62ad9c45ca847ac004a2b16807a63763e5c29 --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=62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 09:06:34,214 truncating revision to first 12 chars 2016-05-12 09:06:34,214 Setting DEBUG logging. 2016-05-12 09:06:34,214 attempt 1/10 2016-05-12 09:06:34,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fca62ad9c45c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 09:06:34,551 unpacking tar archive at: mozilla-aurora-fca62ad9c45c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643552 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:34.416426) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:34.416781) ========= script_repo_revision: fca62ad9c45ca847ac004a2b16807a63763e5c29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:34.417230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:34.417553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 09:06:34.426944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-12 09:06:34.427270) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:06:34 INFO - MultiFileLogger online at 20160512 09:06:34 in /builds/slave/test 09:06:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:06:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:06:34 INFO - {'append_to_log': False, 09:06:34 INFO - 'base_work_dir': '/builds/slave/test', 09:06:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:06:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:06:34 INFO - 'branch': 'Mozilla-Aurora', 09:06:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:06:34 INFO - 'config_files': ('talos/linux_config.py',), 09:06:34 INFO - 'default_actions': ('clobber', 09:06:34 INFO - 'read-buildbot-config', 09:06:34 INFO - 'download-and-extract', 09:06:34 INFO - 'populate-webroot', 09:06:34 INFO - 'create-virtualenv', 09:06:34 INFO - 'install', 09:06:34 INFO - 'run-tests'), 09:06:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:06:34 INFO - 'download_minidump_stackwalk': True, 09:06:34 INFO - 'download_symbols': 'ondemand', 09:06:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:06:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:06:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:06:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:06:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:06:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:06:34 INFO - 'installer_path': 'installer.exe', 09:06:34 INFO - 'log_level': 'info', 09:06:34 INFO - 'log_name': 'talos', 09:06:34 INFO - 'log_to_console': True, 09:06:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:06:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:06:34 INFO - 'opt_config_files': (), 09:06:34 INFO - 'pip_index': False, 09:06:34 INFO - 'sps_profile': False, 09:06:34 INFO - 'sps_profile_interval': 0, 09:06:34 INFO - 'suite': 'dromaeojs-e10s', 09:06:34 INFO - 'system_bits': '32', 09:06:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:06:34 INFO - 'title': 'talos-linux64-ix-018', 09:06:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:06:34 INFO - 'use_talos_json': True, 09:06:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:06:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:06:34 INFO - 'work_dir': 'build'} 09:06:34 INFO - ##### 09:06:34 INFO - ##### Running clobber step. 09:06:34 INFO - ##### 09:06:34 INFO - Running pre-action listener: _resource_record_pre_action 09:06:34 INFO - Running main action method: clobber 09:06:34 INFO - rmtree: /builds/slave/test/build 09:06:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:06:35 INFO - Running post-action listener: _resource_record_post_action 09:06:35 INFO - ##### 09:06:35 INFO - ##### Running read-buildbot-config step. 09:06:35 INFO - ##### 09:06:35 INFO - Running pre-action listener: _resource_record_pre_action 09:06:35 INFO - Running main action method: read_buildbot_config 09:06:35 INFO - Using buildbot properties: 09:06:35 INFO - { 09:06:35 INFO - "project": "", 09:06:35 INFO - "product": "firefox", 09:06:35 INFO - "script_repo_revision": "production", 09:06:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:06:35 INFO - "repository": "", 09:06:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:06:35 INFO - "buildid": "20160512061943", 09:06:35 INFO - "pgo_build": "True", 09:06:35 INFO - "basedir": "/builds/slave/test", 09:06:35 INFO - "buildnumber": 312, 09:06:35 INFO - "slavename": "talos-linux64-ix-018", 09:06:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:06:35 INFO - "platform": "ubuntu64_hw", 09:06:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:06:35 INFO - "branch": "mozilla-aurora", 09:06:35 INFO - "repo_path": "releases/mozilla-aurora", 09:06:35 INFO - "revision": "fca62ad9c45ca847ac004a2b16807a63763e5c29", 09:06:35 INFO - "stage_platform": "linux64-pgo", 09:06:35 INFO - "builduid": "5f55196abfaf45eb8d0a191876533746", 09:06:35 INFO - "slavebuilddir": "test" 09:06:35 INFO - } 09:06:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 09:06:35 INFO - Running post-action listener: _resource_record_post_action 09:06:35 INFO - ##### 09:06:35 INFO - ##### Running download-and-extract step. 09:06:35 INFO - ##### 09:06:35 INFO - Running pre-action listener: _resource_record_pre_action 09:06:35 INFO - Running main action method: download_and_extract 09:06:35 INFO - mkdir: /builds/slave/test/build/tests 09:06: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')]} 09:06:35 INFO - https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:06:38 INFO - Downloaded 1361 bytes. 09:06:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:06:38 INFO - Using the following test package requirements: 09:06:38 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:06:38 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:06:38 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:06:38 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'jsshell-linux-x86_64.zip'], 09:06:38 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:06:38 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:06:38 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:06:38 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:06:38 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:06:38 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:06:38 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:38 INFO - https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:06:43 INFO - Downloaded 23799980 bytes. 09:06:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:06:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:06:44 INFO - Return code: 0 09:06:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:44 INFO - https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:06:47 INFO - Downloaded 23799980 bytes. 09:06:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:06:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:06:49 INFO - Return code: 0 09:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:49 INFO - https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:06:50 INFO - Downloaded 10840145 bytes. 09:06:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:06:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:06:50 INFO - Return code: 0 09:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:50 INFO - https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:06:51 INFO - Downloaded 62701708 bytes. 09:06:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:06:51 INFO - mkdir: /builds/slave/test/properties 09:06:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:51 INFO - Contents: 09:06:51 INFO - build_url:https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:06:52 INFO - Running post-action listener: _resource_record_post_action 09:06:52 INFO - Running post-action listener: set_extra_try_arguments 09:06:52 INFO - ##### 09:06:52 INFO - ##### Running populate-webroot step. 09:06:52 INFO - ##### 09:06:52 INFO - Running pre-action listener: _resource_record_pre_action 09:06:52 INFO - Running main action method: populate_webroot 09:06:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:52 INFO - '--tppagecycles', 09:06:52 INFO - '7'], 09:06:52 INFO - 'tests': ['tsvgm']}}, 09:06:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['damp', 'tps']}, 09:06:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'tests': ['damp', 'tps']}, 09:06:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['dromaeo_dom']}, 09:06:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['a11yr', 09:06:52 INFO - 'ts_paint', 09:06:52 INFO - 'tpaint', 09:06:52 INFO - 'sessionrestore', 09:06:52 INFO - 'sessionrestore_no_auto_restore', 09:06:52 INFO - 'tabpaint']}, 09:06:52 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:52 INFO - 'ts_paint', 09:06:52 INFO - 'tpaint', 09:06:52 INFO - 'sessionrestore', 09:06:52 INFO - 'sessionrestore_no_auto_restore', 09:06:52 INFO - 'tabpaint']}, 09:06:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:52 INFO - 'ts_paint', 09:06:52 INFO - 'tpaint', 09:06:52 INFO - 'sessionrestore', 09:06:52 INFO - 'sessionrestore_no_auto_restore', 09:06:52 INFO - 'tabpaint']}, 09:06:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:52 INFO - 'ts_paint', 09:06:52 INFO - 'tpaint', 09:06:52 INFO - 'sessionrestore', 09:06:52 INFO - 'sessionrestore_no_auto_restore', 09:06:52 INFO - 'tabpaint']}, 09:06:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['a11yr', 09:06:52 INFO - 'ts_paint', 09:06:52 INFO - 'tpaint', 09:06:52 INFO - 'sessionrestore', 09:06:52 INFO - 'sessionrestore_no_auto_restore', 09:06:52 INFO - 'tabpaint']}, 09:06:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['a11yr', 09:06:52 INFO - 'ts_paint', 09:06:52 INFO - 'tpaint', 09:06:52 INFO - 'sessionrestore', 09:06:52 INFO - 'sessionrestore_no_auto_restore', 09:06:52 INFO - 'tabpaint']}, 09:06:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['tsvgx', 09:06:52 INFO - 'tsvgr_opacity', 09:06:52 INFO - 'tart', 09:06:52 INFO - 'tscrollx', 09:06:52 INFO - 'cart']}, 09:06:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:52 INFO - 'tsvgr_opacity', 09:06:52 INFO - 'tart', 09:06:52 INFO - 'tscrollx', 09:06:52 INFO - 'cart']}, 09:06:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'talos_options': ['--disable-e10s'], 09:06:52 INFO - 'tests': ['tp5o']}, 09:06:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'tests': ['tp5o']}, 09:06:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'talos_options': ['--disable-e10s', 09:06:52 INFO - '--xperf_path', 09:06:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:52 INFO - 'tests': ['tp5n']}, 09:06:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:52 INFO - 'talos_options': ['--xperf_path', 09:06:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:52 INFO - 'tests': ['tp5n']}}, 09:06:52 INFO - 'talos.zip': {'path': '', 09:06:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:52 INFO - Running post-action listener: _resource_record_post_action 09:06:52 INFO - ##### 09:06:52 INFO - ##### Running create-virtualenv step. 09:06:52 INFO - ##### 09:06:52 INFO - Running pre-action listener: _resource_record_pre_action 09:06:52 INFO - Running main action method: create_virtualenv 09:06:52 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:06:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:52 INFO - Using real prefix '/usr' 09:06:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:55 INFO - Installing pip.................done. 09:06:55 INFO - Return code: 0 09:06:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:06:55 INFO - Using env: {'DISPLAY': ':0', 09:06:55 INFO - 'HOME': '/home/cltbld', 09:06:55 INFO - 'LANG': 'en_US.UTF-8', 09:06:55 INFO - 'LANGUAGE': 'en_US:en', 09:06:55 INFO - 'LOGNAME': 'cltbld', 09:06:55 INFO - 'MAIL': '/var/mail/cltbld', 09:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:55 INFO - 'MOZ_NO_REMOTE': '1', 09:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:55 INFO - 'NO_EM_RESTART': '1', 09:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:55 INFO - 'PWD': '/builds/slave/test', 09:06:55 INFO - 'SHELL': '/bin/bash', 09:06:55 INFO - 'SHLVL': '1', 09:06:55 INFO - 'TERM': 'linux', 09:06:55 INFO - 'TMOUT': '86400', 09:06:55 INFO - 'USER': 'cltbld', 09:06:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:55 INFO - '_': '/tools/buildbot/bin/python'} 09:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:06:55 INFO - Cleaning up... 09:06:55 INFO - Return code: 0 09:06:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:06:55 INFO - Using env: {'DISPLAY': ':0', 09:06:55 INFO - 'HOME': '/home/cltbld', 09:06:55 INFO - 'LANG': 'en_US.UTF-8', 09:06:55 INFO - 'LANGUAGE': 'en_US:en', 09:06:55 INFO - 'LOGNAME': 'cltbld', 09:06:55 INFO - 'MAIL': '/var/mail/cltbld', 09:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:55 INFO - 'MOZ_NO_REMOTE': '1', 09:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:55 INFO - 'NO_EM_RESTART': '1', 09:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:55 INFO - 'PWD': '/builds/slave/test', 09:06:55 INFO - 'SHELL': '/bin/bash', 09:06:55 INFO - 'SHLVL': '1', 09:06:55 INFO - 'TERM': 'linux', 09:06:55 INFO - 'TMOUT': '86400', 09:06:55 INFO - 'USER': 'cltbld', 09:06:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:55 INFO - '_': '/tools/buildbot/bin/python'} 09:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:55 INFO - Downloading/unpacking psutil>=0.7.1 09:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:57 INFO - Installing collected packages: psutil 09:06:57 INFO - Running setup.py install for psutil 09:06:57 INFO - building 'psutil._psutil_linux' extension 09:06:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:06:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:06:57 INFO - building 'psutil._psutil_posix' extension 09:06:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:06:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:06:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:58 INFO - Successfully installed psutil 09:06:58 INFO - Cleaning up... 09:06:58 INFO - Return code: 0 09:06:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:06:58 INFO - Using env: {'DISPLAY': ':0', 09:06:58 INFO - 'HOME': '/home/cltbld', 09:06:58 INFO - 'LANG': 'en_US.UTF-8', 09:06:58 INFO - 'LANGUAGE': 'en_US:en', 09:06:58 INFO - 'LOGNAME': 'cltbld', 09:06:58 INFO - 'MAIL': '/var/mail/cltbld', 09:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:58 INFO - 'MOZ_NO_REMOTE': '1', 09:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:58 INFO - 'NO_EM_RESTART': '1', 09:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:58 INFO - 'PWD': '/builds/slave/test', 09:06:58 INFO - 'SHELL': '/bin/bash', 09:06:58 INFO - 'SHLVL': '1', 09:06:58 INFO - 'TERM': 'linux', 09:06:58 INFO - 'TMOUT': '86400', 09:06:58 INFO - 'USER': 'cltbld', 09:06:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:58 INFO - '_': '/tools/buildbot/bin/python'} 09:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:07:00 INFO - Installing collected packages: mozsystemmonitor 09:07:00 INFO - Running setup.py install for mozsystemmonitor 09:07:00 INFO - Successfully installed mozsystemmonitor 09:07:00 INFO - Cleaning up... 09:07:00 INFO - Return code: 0 09:07:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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', '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 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:07: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 blobuploader==1.2.4 09:07:00 INFO - Using env: {'DISPLAY': ':0', 09:07:00 INFO - 'HOME': '/home/cltbld', 09:07:00 INFO - 'LANG': 'en_US.UTF-8', 09:07:00 INFO - 'LANGUAGE': 'en_US:en', 09:07:00 INFO - 'LOGNAME': 'cltbld', 09:07:00 INFO - 'MAIL': '/var/mail/cltbld', 09:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:00 INFO - 'MOZ_NO_REMOTE': '1', 09:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:00 INFO - 'NO_EM_RESTART': '1', 09:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:00 INFO - 'PWD': '/builds/slave/test', 09:07:00 INFO - 'SHELL': '/bin/bash', 09:07:00 INFO - 'SHLVL': '1', 09:07:00 INFO - 'TERM': 'linux', 09:07:00 INFO - 'TMOUT': '86400', 09:07:00 INFO - 'USER': 'cltbld', 09:07:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:00 INFO - '_': '/tools/buildbot/bin/python'} 09:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:03 INFO - Downloading docopt-0.6.1.tar.gz 09:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:03 INFO - Running setup.py install for blobuploader 09:07:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:03 INFO - Running setup.py install for requests 09:07:03 INFO - Running setup.py install for docopt 09:07:03 INFO - Successfully installed blobuploader requests docopt 09:07:03 INFO - Cleaning up... 09:07:03 INFO - Return code: 0 09:07:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 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 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:07:03 INFO - Using env: {'DISPLAY': ':0', 09:07:03 INFO - 'HOME': '/home/cltbld', 09:07:03 INFO - 'LANG': 'en_US.UTF-8', 09:07:03 INFO - 'LANGUAGE': 'en_US:en', 09:07:03 INFO - 'LOGNAME': 'cltbld', 09:07:03 INFO - 'MAIL': '/var/mail/cltbld', 09:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:03 INFO - 'MOZ_NO_REMOTE': '1', 09:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:03 INFO - 'NO_EM_RESTART': '1', 09:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:03 INFO - 'PWD': '/builds/slave/test', 09:07:03 INFO - 'SHELL': '/bin/bash', 09:07:03 INFO - 'SHLVL': '1', 09:07:03 INFO - 'TERM': 'linux', 09:07:03 INFO - 'TMOUT': '86400', 09:07:03 INFO - 'USER': 'cltbld', 09:07:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:03 INFO - '_': '/tools/buildbot/bin/python'} 09:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:04 INFO - Running setup.py (path:/tmp/pip-Fet2Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:04 INFO - Running setup.py (path:/tmp/pip-uTKNCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:04 INFO - Running setup.py (path:/tmp/pip-T3XBfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:04 INFO - Running setup.py (path:/tmp/pip-rninJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:04 INFO - Running setup.py (path:/tmp/pip-_SMlaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:04 INFO - Running setup.py (path:/tmp/pip-sydyGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:04 INFO - Running setup.py (path:/tmp/pip-36qPce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:04 INFO - Running setup.py (path:/tmp/pip-au8geu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:04 INFO - Running setup.py (path:/tmp/pip-5dSTV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:04 INFO - Running setup.py (path:/tmp/pip-U40Dg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:04 INFO - Running setup.py (path:/tmp/pip-MI4KoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:04 INFO - Running setup.py (path:/tmp/pip-9jmjV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:04 INFO - Running setup.py (path:/tmp/pip-AzvrCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:05 INFO - Running setup.py (path:/tmp/pip-XVEKl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:05 INFO - Running setup.py (path:/tmp/pip-JRd3rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:05 INFO - Running setup.py (path:/tmp/pip-LH__LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:05 INFO - Running setup.py (path:/tmp/pip-Yn7ITa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:05 INFO - Running setup.py install for manifestparser 09:07:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:05 INFO - Running setup.py install for mozcrash 09:07:05 INFO - Running setup.py install for mozdebug 09:07:05 INFO - Running setup.py install for mozdevice 09:07:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:05 INFO - Running setup.py install for mozfile 09:07:05 INFO - Running setup.py install for mozhttpd 09:07:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:05 INFO - Running setup.py install for mozinfo 09:07:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Running setup.py install for mozInstall 09:07:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Running setup.py install for mozleak 09:07:06 INFO - Running setup.py install for mozlog 09:07:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Running setup.py install for moznetwork 09:07:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Running setup.py install for mozprocess 09:07:06 INFO - Running setup.py install for mozprofile 09:07:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Running setup.py install for mozrunner 09:07:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:06 INFO - Running setup.py install for mozscreenshot 09:07:06 INFO - Running setup.py install for moztest 09:07:06 INFO - Running setup.py install for mozversion 09:07:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:07 INFO - Cleaning up... 09:07:07 INFO - Return code: 0 09:07:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:07 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 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:07:07 INFO - Using env: {'DISPLAY': ':0', 09:07:07 INFO - 'HOME': '/home/cltbld', 09:07:07 INFO - 'LANG': 'en_US.UTF-8', 09:07:07 INFO - 'LANGUAGE': 'en_US:en', 09:07:07 INFO - 'LOGNAME': 'cltbld', 09:07:07 INFO - 'MAIL': '/var/mail/cltbld', 09:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:07 INFO - 'MOZ_NO_REMOTE': '1', 09:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:07 INFO - 'NO_EM_RESTART': '1', 09:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:07 INFO - 'PWD': '/builds/slave/test', 09:07:07 INFO - 'SHELL': '/bin/bash', 09:07:07 INFO - 'SHLVL': '1', 09:07:07 INFO - 'TERM': 'linux', 09:07:07 INFO - 'TMOUT': '86400', 09:07:07 INFO - 'USER': 'cltbld', 09:07:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:07 INFO - '_': '/tools/buildbot/bin/python'} 09:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:07 INFO - Running setup.py (path:/tmp/pip-gZKi33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:07 INFO - Running setup.py (path:/tmp/pip-pWSb4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:07 INFO - Running setup.py (path:/tmp/pip-TbgE4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:07 INFO - Running setup.py (path:/tmp/pip-7FrHxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:07 INFO - Running setup.py (path:/tmp/pip-FtfRL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:07 INFO - Running setup.py (path:/tmp/pip-b04v6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:07 INFO - Running setup.py (path:/tmp/pip-lu777R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:07 INFO - Running setup.py (path:/tmp/pip-ynCXe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:07 INFO - Running setup.py (path:/tmp/pip-THYl_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:07 INFO - Running setup.py (path:/tmp/pip-3y56iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:08 INFO - Running setup.py (path:/tmp/pip-Nbto8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:08 INFO - Running setup.py (path:/tmp/pip-u_eVto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:08 INFO - Running setup.py (path:/tmp/pip-a5KwLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:08 INFO - Running setup.py (path:/tmp/pip-AzfNvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:08 INFO - Running setup.py (path:/tmp/pip-BMekzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:08 INFO - Running setup.py (path:/tmp/pip-Xmv8Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:08 INFO - Running setup.py (path:/tmp/pip-yOMb2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:10 INFO - Downloading blessings-1.6.tar.gz 09:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:10 INFO - Installing collected packages: blessings 09:07:10 INFO - Running setup.py install for blessings 09:07:10 INFO - Successfully installed blessings 09:07:10 INFO - Cleaning up... 09:07:10 INFO - Return code: 0 09:07:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:10 INFO - Reading from file tmpfile_stdout 09:07:10 INFO - Current package versions: 09:07:10 INFO - argparse == 1.2.1 09:07:10 INFO - blessings == 1.6 09:07:10 INFO - blobuploader == 1.2.4 09:07:10 INFO - docopt == 0.6.1 09:07:10 INFO - manifestparser == 1.1 09:07:10 INFO - mozInstall == 1.12 09:07:10 INFO - mozcrash == 0.17 09:07:10 INFO - mozdebug == 0.1 09:07:10 INFO - mozdevice == 0.48 09:07:10 INFO - mozfile == 1.2 09:07:10 INFO - mozhttpd == 0.7 09:07:10 INFO - mozinfo == 0.9 09:07:10 INFO - mozleak == 0.1 09:07:10 INFO - mozlog == 3.1 09:07:10 INFO - moznetwork == 0.27 09:07:10 INFO - mozprocess == 0.22 09:07:10 INFO - mozprofile == 0.28 09:07:10 INFO - mozrunner == 6.11 09:07:10 INFO - mozscreenshot == 0.1 09:07:10 INFO - mozsystemmonitor == 0.0 09:07:10 INFO - moztest == 0.7 09:07:10 INFO - mozversion == 1.4 09:07:10 INFO - psutil == 3.1.1 09:07:10 INFO - requests == 1.2.3 09:07:10 INFO - wsgiref == 0.1.2 09:07:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:10 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 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:07:10 INFO - Using env: {'DISPLAY': ':0', 09:07:10 INFO - 'HOME': '/home/cltbld', 09:07:10 INFO - 'LANG': 'en_US.UTF-8', 09:07:10 INFO - 'LANGUAGE': 'en_US:en', 09:07:10 INFO - 'LOGNAME': 'cltbld', 09:07:10 INFO - 'MAIL': '/var/mail/cltbld', 09:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:10 INFO - 'MOZ_NO_REMOTE': '1', 09:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:10 INFO - 'NO_EM_RESTART': '1', 09:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:10 INFO - 'PWD': '/builds/slave/test', 09:07:10 INFO - 'SHELL': '/bin/bash', 09:07:10 INFO - 'SHLVL': '1', 09:07:10 INFO - 'TERM': 'linux', 09:07:10 INFO - 'TMOUT': '86400', 09:07:10 INFO - 'USER': 'cltbld', 09:07:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:10 INFO - '_': '/tools/buildbot/bin/python'} 09:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:07:11 INFO - Cleaning up... 09:07:11 INFO - Return code: 0 09:07:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:11 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 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:07:11 INFO - Using env: {'DISPLAY': ':0', 09:07:11 INFO - 'HOME': '/home/cltbld', 09:07:11 INFO - 'LANG': 'en_US.UTF-8', 09:07:11 INFO - 'LANGUAGE': 'en_US:en', 09:07:11 INFO - 'LOGNAME': 'cltbld', 09:07:11 INFO - 'MAIL': '/var/mail/cltbld', 09:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:11 INFO - 'MOZ_NO_REMOTE': '1', 09:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:11 INFO - 'NO_EM_RESTART': '1', 09:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:11 INFO - 'PWD': '/builds/slave/test', 09:07:11 INFO - 'SHELL': '/bin/bash', 09:07:11 INFO - 'SHLVL': '1', 09:07:11 INFO - 'TERM': 'linux', 09:07:11 INFO - 'TMOUT': '86400', 09:07:11 INFO - 'USER': 'cltbld', 09:07:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:11 INFO - '_': '/tools/buildbot/bin/python'} 09:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:11 INFO - Downloading/unpacking jsonschema 09:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:13 INFO - Downloading/unpacking functools32 (from jsonschema) 09:07: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 09:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07: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 09:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:13 INFO - warning: no files found matching '*.txt' 09:07:13 INFO - no previously-included directories found matching 'build' 09:07:13 INFO - no previously-included directories found matching 'dist' 09:07:13 INFO - no previously-included directories found matching '.git*' 09:07:13 INFO - Installing collected packages: jsonschema, functools32 09:07:13 INFO - Running setup.py install for functools32 09:07:13 INFO - warning: no files found matching '*.txt' 09:07:13 INFO - no previously-included directories found matching 'build' 09:07:13 INFO - no previously-included directories found matching 'dist' 09:07:13 INFO - no previously-included directories found matching '.git*' 09:07:13 INFO - Successfully installed jsonschema functools32 09:07:13 INFO - Cleaning up... 09:07:13 INFO - Return code: 0 09:07:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f755711ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07: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', 'flake8'] in /builds/slave/test/build 09:07: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 flake8 09:07:13 INFO - Using env: {'DISPLAY': ':0', 09:07:13 INFO - 'HOME': '/home/cltbld', 09:07:13 INFO - 'LANG': 'en_US.UTF-8', 09:07:13 INFO - 'LANGUAGE': 'en_US:en', 09:07:13 INFO - 'LOGNAME': 'cltbld', 09:07:13 INFO - 'MAIL': '/var/mail/cltbld', 09:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:13 INFO - 'MOZ_NO_REMOTE': '1', 09:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:13 INFO - 'NO_EM_RESTART': '1', 09:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:13 INFO - 'PWD': '/builds/slave/test', 09:07:13 INFO - 'SHELL': '/bin/bash', 09:07:13 INFO - 'SHLVL': '1', 09:07:13 INFO - 'TERM': 'linux', 09:07:13 INFO - 'TMOUT': '86400', 09:07:13 INFO - 'USER': 'cltbld', 09:07:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:13 INFO - '_': '/tools/buildbot/bin/python'} 09:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:14 INFO - Downloading/unpacking flake8 09:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:07:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:07:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:07:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:07:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:07:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:07:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:07:16 INFO - no previously-included directories found matching 'docs/_build' 09:07:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:07:16 INFO - Running setup.py install for pep8 09:07:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:07:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:07:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:07:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:07:16 INFO - no previously-included directories found matching 'docs/_build' 09:07:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:07:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:07:16 INFO - Cleaning up... 09:07:16 INFO - Return code: 0 09:07:16 INFO - Running post-action listener: _resource_record_post_action 09:07:16 INFO - Running post-action listener: _start_resource_monitoring 09:07:16 INFO - Starting resource monitoring. 09:07:16 INFO - ##### 09:07:16 INFO - ##### Running install step. 09:07:16 INFO - ##### 09:07:16 INFO - Running pre-action listener: _resource_record_pre_action 09:07:16 INFO - Running main action method: install 09:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:17 INFO - Reading from file tmpfile_stdout 09:07:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:17 INFO - Reading from file tmpfile_stdout 09:07:17 INFO - Output received: 09:07:17 INFO - Usage: mozinstall [options] installer 09:07:17 INFO - Options: 09:07:17 INFO - -h, --help show this help message and exit 09:07:17 INFO - -d DEST, --destination=DEST 09:07:17 INFO - Directory to install application into. [default: 09:07:17 INFO - "/builds/slave/test"] 09:07:17 INFO - --app=APP Application being installed. [default: firefox] 09:07:17 INFO - mkdir: /builds/slave/test/build/application 09:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:07:32 INFO - Reading from file tmpfile_stdout 09:07:32 INFO - Output received: 09:07:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:07:32 INFO - Running post-action listener: _resource_record_post_action 09:07:32 INFO - ##### 09:07:32 INFO - ##### Running run-tests step. 09:07:32 INFO - ##### 09:07:32 INFO - Running pre-action listener: _resource_record_pre_action 09:07:32 INFO - Running main action method: run_tests 09:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:32 INFO - Python 2.7.3 09:07:32 INFO - Return code: 0 09:07:32 INFO - grabbing minidump binary from tooltool 09:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:32 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 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:07:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:07:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:32 INFO - Return code: 0 09:07:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:07:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:07:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:07:33 INFO - Return code: 0 09:07:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:07:33 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:07:33 INFO - Using env: {'DISPLAY': ':0', 09:07:33 INFO - 'HOME': '/home/cltbld', 09:07:33 INFO - 'LANG': 'en_US.UTF-8', 09:07:33 INFO - 'LANGUAGE': 'en_US:en', 09:07:33 INFO - 'LOGNAME': 'cltbld', 09:07:33 INFO - 'MAIL': '/var/mail/cltbld', 09:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:33 INFO - 'MOZ_NO_REMOTE': '1', 09:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:33 INFO - 'NO_EM_RESTART': '1', 09:07:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:33 INFO - 'PWD': '/builds/slave/test', 09:07:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:33 INFO - 'SHELL': '/bin/bash', 09:07:33 INFO - 'SHLVL': '1', 09:07:33 INFO - 'TERM': 'linux', 09:07:33 INFO - 'TMOUT': '86400', 09:07:33 INFO - 'USER': 'cltbld', 09:07:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573', 09:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:33 INFO - '_': '/tools/buildbot/bin/python'} 09:07:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:07:34 INFO - mozversion application_buildid: 20160512061943 09:07:34 INFO - mozversion application_changeset: fca62ad9c45ca847ac004a2b16807a63763e5c29 09:07:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:07:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:34 INFO - mozversion application_name: Firefox 09:07:34 INFO - mozversion application_remotingname: firefox-dev 09:07:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:34 INFO - mozversion application_vendor: Mozilla 09:07:34 INFO - mozversion application_version: 48.0a2 09:07:34 INFO - mozversion platform_buildid: 20160512061943 09:07:34 INFO - mozversion platform_changeset: fca62ad9c45ca847ac004a2b16807a63763e5c29 09:07:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:34 INFO - mozversion platform_version: 48.0a2 09:07:34 INFO - using testdate: 1463069254 09:07:34 INFO - actual date: 1463069254 09:07:34 INFO - starting webserver on 'localhost:37989' 09:07:34 INFO - SUITE-START | Running 2 tests 09:07:34 INFO - TEST-START | dromaeo_css 09:07:34 INFO - operating with platform_type : linux_ 09:07:34 INFO - Initialising browser for dromaeo_css test... 09:07:34 INFO - TEST-INFO | started process 27862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqYgD9w/profile http://localhost:37989/getInfo.html) 09:07:37 INFO - PROCESS | 27862 | 09:07:37 INFO - PROCESS | 27862 | (process:27939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:07:38 INFO - PROCESS | 27862 | __metrics Screen width/height:1600/1200 09:07:38 INFO - PROCESS | 27862 | colorDepth:24 09:07:38 INFO - PROCESS | 27862 | Browser inner width/height: 1024/697 09:07:38 INFO - PROCESS | 27862 | __metrics 09:07:38 ERROR - PROCESS | 27862 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:07:39 INFO - TEST-INFO | 27862: exit 0 09:07:39 INFO - Browser initialized. 09:07:39 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:39 INFO - TEST-INFO | started process 27991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqYgD9w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:41 INFO - PROCESS | 27991 | 09:07:41 INFO - PROCESS | 27991 | (process:28062): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:07:51 INFO - PROCESS | 27991 | RSS: Main: 152281088 09:07:51 INFO - PROCESS | 27991 | 09:08:41 INFO - PROCESS | 27991 | 1463069321165 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:10:48 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:37989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37989/tests/dromaeo/cssquery-ext.html) 09:10:49 INFO - PROCESS | 27991 | RSS: Main: 156352512 09:10:49 INFO - PROCESS | 27991 | 09:13:51 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:37989/tests/dromaeo/cssquery-ext.html (next: http://localhost:37989/tests/dromaeo/cssquery-jquery.html) 09:13:51 INFO - PROCESS | 27991 | RSS: Main: 153497600 09:13:51 INFO - PROCESS | 27991 | 09:16:53 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:37989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37989/tests/dromaeo/cssquery-mootools.html) 09:16:54 INFO - PROCESS | 27991 | RSS: Main: 153374720 09:16:54 INFO - PROCESS | 27991 | 09:19:55 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:37989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37989/tests/dromaeo/cssquery-prototype.html) 09:19:56 INFO - PROCESS | 27991 | RSS: Main: 153456640 09:19:56 INFO - PROCESS | 27991 | 09:22:58 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:37989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37989/tests/dromaeo/cssquery-yui.html) 09:22:59 INFO - PROCESS | 27991 | RSS: Main: 154955776 09:22:59 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:37989/tests/dromaeo/cssquery-yui.html (next: http://localhost:37989/tests/dromaeo/cssquery-dojo.html) 09:26:01 INFO - PROCESS | 27991 | RSS: Main: 156119040 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | __start_tp_report 09:26:01 INFO - PROCESS | 27991 | _x_x_mozilla_page_load 09:26:01 INFO - PROCESS | 27991 | _x_x_mozilla_page_load_details 09:26:01 INFO - PROCESS | 27991 | |i|pagename|runs| 09:26:01 INFO - PROCESS | 27991 | |0;dojo.html;3367.2255381262307;3375.848086836092;3397.728181745459;3412.232247744258;3417.2652879630873;5458.890822183554;5471.015217260897;5478.342598888139;5508.889822203553;5511.53151982081;5455.754491047903;5468.644538105021;5472.1244600863865;5489.478499542547;5525.972370138144;4971.975140124295;4986.626003049786;4997;5054.797808087672;5073.188289873621;4981.825636102737;5064;5071.7210553419545;5084.872878178038;5103.4896510349035;5063.721495317756;5066.771995260222;5073.619478539106;5108.974455127719;5170.896582068356;4984.352034235562;4987.576056035241;4999.675021123651;5014.1225285575065;5022.372203474566;4898.167311557044;4901.43633482147;4936.6297527685565;4966.677165984235;4972.154733695281;5349.197620356938;5396.865078373033;5397.946020539784;5411.053065713484;5468.179773034037;5854.912176317316;5903.940960590382;5924.763009479616;5931.525477961753;5941.287045554518;5949.940500594982;5977.970110149421;5979.5515336349945;5980;5988.640681559121;5413.566914646858;5492.148716948879;5590.413006634326;5607.55139588836;5660.632058916157;6073.75704971805;6078.6048906820915;6084.695765211722;6095.603785753912;6098.847528811726;5784.971075144597;5828.795992140254;5832.037713777179;5833.912491312633;5840.065589505659;5974.790882319098;6029.155918171459;6036.63780173191;6050.909236361458;6072.149899014142;5876.236089308448;5905.911411328833;5935.554833387513;5958.046712525975;5968.283805943314;5717.17101020358;5889.5877288590245;5916.792912248051;5960.612560183574;5990.28116625999;4540.727556346564;4557.043020965634;4562.657800664963;4571.337156112345;4593.379893714306;4077.1641813428178;4089.97955010229;4109.773962432035;4121.835126594962;4127.669786417079;5510.201020851954;5535;5559.138333558305;5756.309242890796;5772.105323674838;5816.098504731774;5941;5998.70006499682;6012.39876012404;6049.304330002018;5723.685197314105;5744.770209191669;5750.2237197978575;5750.30996280449;5751.051076572402;4925.729084900365;4953.083679519228;4981.701097934136;4985.601151907838;5004.549590536796;6160.1375807387;6200.348963358872;6205.6586887721605;6211.3478084801345;6220.191375121296;5972.372900845522;5999.220101386792;6015.939840601538;6034.788782392595;6040.003399439043;6109.313572000111;6117.510599151969;6193.4425901669065;6216.968915155395;6221.035739460391;5820.679862607597;5821.76712931478;5827.854303642443;5834.591578589458;5874.118882167709;5754.971225143848;5869.295684517885;5869.8239052828485;5873.676947767914;5881.735321910439;5713.114467257582;5738.655680659173;5768.826935191951;5769.0481070624555;5820.476157145878;5684.374718781013;5728.169415434655;5760.366359700346;5771.249737534094;5774.105013722879;5584.636998595079;5607.102863541813;5640.915386269291;5668.234788303526;5695.430456954271;5823.068309070529;5833.649981001154;5868.471837534642;5882.911756323744;5910.734016969161;5688.033034384247;5691.7438715257085;5693.658380497183;5722.484976352148;5734.311882574118 09:26:01 INFO - PROCESS | 27991 | |1;ext.html;669.4577392312227;669.4844969373579;673.168636733634;726.5277569579772;735.1986334894965;39371.60628393715;40443.191136177295;40660;40709.592904070916;40857.59142408575;43287.35068973968;43376.13247735043;43674.563254367444;43698.34452483215;44102;8845.159709827556;8962.238209752146;9000.144986226298;9002.684906028291;9012.909870901305;8718.17177368149;8858.114188581123;8872.645094196258;8876.556172191396;8879.156480134408;9123.771905702377;9150.496722680284;9152.084791520861;9157;9216.354855160109;9038.141376569249;9145.268378529734;9146.86279705805;9171.449713017173;9176.357654964155;9126.680566180152;9190.908090919072;9217.216536594398;9221.631134754602;9232.769180770467;40382.79808600938;41115.58884411177;41117;41211.793941030104;41267.7936610315;3822.311983842907;4012.959870401288;4087.9386809197886;4426.402435671175;4680.157571637104;32826;32934;33225.501617475755;33478.33043339144;34362;4546.499885012646;4596.448426188846;4620.8151673933;4649.3970968740705;4671.182543054986;313067;316470;317814.9999999977;318324;320107;63332.36667633357;63345.683271583344;63637.04544431837;63703;63782.36217637857;69534.30465695278;71224;73557.63221183966;73575.63212183905;73609.26390736131;17561.12194390301;17797.644047118985;17871.642567148843;17895.194716237802;17898.463046108638;13321.467141314433;13517.86482135166;13525.797113043312;13540;13577.11748736329;20711.482212944495;20766.273180438613;20891.059902304434;20947;20957.26649567258;7696.807579810549;7954.125046244909;8016.599170041592;8049.235322644339;8284.544350060683;1101.5758932810925;1106.980013961016;1111.9888801112047;1196.1088988703298;1287.9742405151844;33470.497942530885;33891.491627625604;34007.65992340094;34224.657753422645;34291.43286747771;1216.9513219471298;1246.501399440213;1285.1068507387276;1332.9600111996656;1367.407304126129;17065.488035358958;17242.741358879626;17425.82574174242;17459;17763.20065597051;477972;491500;523449;534558;558482;57797.71101144551;58708.706456467444;58934.41065589375;59024;59098.704506478054;1503.5940296120204;1505.284989629917;1517.6433538118533;1523.581015220801;1633.1670847867672;33938.830305848314;34302;34468.48297275593;34561.30877382388;34568.13579660529;55912.44087559235;56338.43661563496;56733.432665672815;56760;56848.715756420956;425460;429766;432439;434692;435073;31358.05925822229;31916.24460654686;32055.519167212045;32084;32096;50983.23525147051;51375.48624513707;51974;52218.21672674989;52607.47392526179;42797.35803963005;43456.34815477707;43641;43685.344719828594;43884.341734874644;43185;43512.12975740404;43700;43839.56160438355;43843.78078109589;43338.78330608327;44383.77808111068;44631.776841115585;44686;44686.3297050551;36525;37189.25621487609;37380;37480.250394992494;37935.43096853494;28650;29558.852205739695;29584.260393490335;29848.25379365533;30148.24629384283 09:26:01 INFO - PROCESS | 27991 | |2;jquery.html;408.7363650445462;416.15312838373916;421.65424352031346;425.4979124632933;432.1098537013752;18502.629947401045;18933.242670293188;19117.71323430148;19605.803941960578;20757.792422075774;19815.900920495376;19997.60004799907;20259.79740202601;20268.29060982866;20333.898330508364;5630.7184640768;5710.400407957167;5809.2738407699035;5836.941630583704;5905.995980683273;5710.685912274823;5753.741081651315;5764.135379693038;5765.308163020443;5819.039858423355;5624.325080990287;5697.4587414195585;5704.372519022904;5743.827685169452;5874.9118763218585;5726.284214473191;5769.16347129666;5810.767569297244;5823.796167134173;5858.297004359483;5221.216817477409;5224;5239.187925871496;5254.185601231777;5256.027634887558;23156.3053108407;23506.882465587732;23982.40043998914;24051.39871503209;24076;2423.4062654649547;2578.8839502222445;2698.6491756071587;2817.394260234039;2911.4759343318196;14721.779173312409;14738.778918316233;14827.555173344817;15165.09009459436;15167.772483412758;2033.522122301258;2045.4375046862083;2047.6109539187655;2124.2034237161065;2124.904379302935;78998.6050069746;80390.5980470094;80958;81306;81427;10308.32995855267;10495.422751748727;10517.9474102629;10730.141588672888;10731.302465339728;13997.580072597839;14016.71966560663;14099.295035248197;14112.71774564503;14207.71584568303;8160.714374996846;8175.264226219669;8281.54451505173;8344;8379.203975622306;8071.434999549975;8163.3061189798345;8173.591320433955;8222.72547755099;8233.053198882086;6650.90023649636;6670.966645166744;6676.599404035774;6722.66386680664;6730;1873.7189421586597;1909.9236030558623;1923.5768131011155;1928.23834585338;1941.213808407597;1014.7564584499667;1098.1653943003375;1124.4377811094453;1180.6694125644833;1207.215310048458;19239.711404328948;19285.710714339297;19627.901860490892;19728.70406943897;20169.09239084245;1082.5074591061048;1142.7771584541101;1171.83008463774;1187.679326581818;1197.7424853656505;11424.069725118314;11441.199116061962;11468.426578671033;11500.94249528747;11566.768664626661;185042;186125;187035;188623;188970;66871.66564167246;71362;72934.63532682303;75312.24687753052;81788.59105704553;1097.434821067151;1115.0299239661383;1131.7623299107279;1162.4768854015726;1166.5275563396838;17582.73625895638;17889.37387191442;18077.457676269732;18195.54511137232;18371.90814045921;35504.28991420209;35828.462573060904;36549;36960.63039369572;37849.4322585156;50227;51196.232056519926;51528.74235628948;51633.7418312906;51768.223476648636;8883.466991980502;8985;9055.90944090577;9082.818343633222;9153.221976132103;13746.518871839839;13888.861111388756;13981.370838312503;14184.50354237638;14198.716025679636;12154.574589889311;12323.876761232274;12500.312482813533;12656.43046062911;12729.79932560665;11989.22070065443;12168.513259469522;12181.39093045362;12266.448009839758;12460.56388026451;12148.878511215129;12256.938715306367;12307.69230769238;12450.937745311216;12569.371531423209;8556;8596.871046934177;8640.351973601879;8702.129787021247;8767.649294028168;11949.283043017447;12053.75892482163;12069.698257543632;12247.69380765488;12259.080568957543 09:26:01 INFO - PROCESS | 27991 | |3;mootools.html;1556.64197234636;1581.3516458252118;1760.3486709917333;1862.841658459031;1867.69183084791;6930.584164950106;7508.249175082489;7528.247175282469;7690.538567685936;7709.226877818105;7563.621818909046;7614.086309642837;7615.276548727862;7678.577678227695;7686.769396918087;2173.913043478259;2293.552757212344;2297;2306.4349234437586;2310.3992961829877;2265.139247086105;2285.7942785149335;2294.3346429535413;2315.6758053872472;2325.162941341116;2272.125231785758;2284.097781376355;2316.108298305156;2326.1974618756585;2344.988275058622;2295.8392912496133;2306.3542208181734;2308.4459729664927;2318.374039009475;2325.5116425550655;2260.8982595783227;2263.038208761286;2264.6942662740485;2269.024319542596;2285.4743409015855;7812;7821.491603045783;7837.1379148293645;7893.052833659997;7899.565523896184;4685.461171965234;4692.976535117336;4741.620670346364;4741.786619602091;4761.785719642625;3259.3970115528705;3298.818564978925;3452.085197422685;3461.7403694723;3488.825558722079;1156.9074474042056;1164.586571767019;1201.5941348622132;1201.6755476021426;1227.1777908801037;10844.295120817122;10856;10948.288361256493;10965.342079475256;10969.890301096966;4301.354796780508;4305.526392096866;4340.348947657877;4342.066455712037;4353.499347575006;9332.626694932262;9358.970513243537;9361;9384.765380865396;9402.576884040234;4974.353334066621;4976.552110310089;4979.775910084055;4981.9252711209365;4983.725895075806;4068.0846809467635;4449.243628583084;4496.4154659894;4540.137373898949;4569.086182763461;3821.3503704370323;3914.0606254498716;3928.823202955874;3962.2471730371135;4056.7363121397016;1235.6663700800914;1254.792959161728;1256.7926292161874;1277.3549357574366;1283.9871601284055;941.868138460616;1034.4000479721744;1037.5538518436992;1042.2495803021811;1066.8026415113075;5501.449855014466;5509.696966666792;5580.330360356783;5629.7185140742795;5633.915491267634;424.0733996218273;427.61514636827104;432.97185682930507;437.6389478680102;437.8839607504014;4001.7598944063448;4001.919961600752;4020.276350256982;4022.7385219961193;4082.4896887889013;9600.135987760996;9859.50702464874;9989.450580218012;10011.249156313306;10041.698749037541;9620.855687164698;9677.612895484102;9753.951230243803;9781.46201958885;9856.45789481571;7717.073951125901;7718.614069296513;7808.570528620867;7837.568933708587;7846.9607651962515;5516.365617953827;5528.308961379827;5600.299962504687;5710.3433105193435;5726.284214473191;8556.358273129665;8670.479771213748;8725.171108744658;8810.515421651871;8849.115088491099;8644.481331120152;8674.30605551567;8712.433691810013;8763.123687631185;8798.780030499289;6269.905951410824;6662.100616416722;6822.795316140524;6970.686319115551;7028.753993610199;7401.962990185015;7585.886211706939;7593.468457207942;7597.88603170964;7650.273224043707;6785.355391238022;7017.789466316019;7027;7086.964565177141;7117.644117793986;6691.966540167268;6810.489213308922;6954.165500140016;7011.123609548807;7039.788806335818;6302.212223472066;6318.052292156213;6375.075614035846;6548.508861835287;6601;4876.317315575893;4877.244027175793;4927.28554359623;5013.548780609763;5072.340595722532;4909.288153217692;4920.778564964514;4955.479674634112;4999.075171093359;5025.045241404122 09:26:01 INFO - PROCESS | 27991 | |4;prototype.html;336.1776600057348;341.4076577138664;341.69983213871217;344.5142349287505;344.86205517792894;6497.8375540611505;6546.312637173088;6623.2383275923285;6674.332566743317;6690.966545167274;6601.174853143357;6655.500837437187;6667.933130699089;6670.166229221348;6705.195376554808;5007.674501157431;5008.398992120941;5009.023240468092;5009.649324547283;5017;4998.425181104183;5004.124278251292;5014.924776128361;5015.623828212881;5015.824446144386;4952.826651067214;4957.231629097478;4959.82640607577;4979.576735977446;4980.153373926423;4775.952240477585;4900.338454308659;4966.553010229079;4970.304157417964;4985.077760614298;4298.290782020963;4299.183155200533;4302.290122129845;4318.373835793824;4321.762303073329;6298.622082675009;6316.652584107872;6319.178506794134;6332.620042797447;6343.936560634427;5768.048272035109;5804.970975145097;5811.27359080115;5819;5822.650640961556;6934.063901373351;6966.616836074014;6982.371586557183;6987.406070484015;6992.79021629352;4664.510226426244;4811.422629284508;4829.951700482985;4830.106430310404;4830.9275360869615;7286.562806231643;7341.412686985029;7371.852562948711;7379.040724705754;7379.6679149438405;4959.925601115986;4961.305417241589;4962.280469331927;4962.727050012284;4963.181075122564;5031.924521132186;5033.6476446648385;5034.572061374751;5036.64743467961;5049.444561098277;5812.9709351452975;5814.79648212319;5816.272965879265;5818.069108942549;5826.708664566755;6844.486663500257;7044.964775176194;7049.541779784297;7055.118110236221;7065.505414620927;1732.281103342099;1767.3990843113404;1767.558110472382;1771.3800169940675;1775.5472354549506;1087.5106202209038;1145.4043897173424;1151.5566506894907;1172.9648110556698;1174.2543484886987;6800.727970881208;6905.689243984033;6932.688029038705;6956.165260168812;6977.058097156921;7268.818279543054;7307.086614173229;7329.377002954702;7330.450216233698;7333.74331898381;6837.38463538274;6862.9313706863295;6864.249616347799;6883.8967415488805;6889.242183359826;3884.553276373253;3893.2992061429213;3927.8625248116177;3932.980335098306;3954.2486927483687;7618.923810761932;7619.619019049025;7620.047494063242;7640.885386719204;7640.923590764021;7424.777256682308;7468.9626551866895;7494.40044796415;7508.662110205054;7517.323440890346;7602.961985190039;7608.80977975544;7612.162662107164;7619.923800762032;7633.465657404039;7126.750563730245;7228.530145540523;7245.963770181115;7260.818479538054;7287.4534409920525;7098.574085554883;7150.14198296187;7178.4257259420165;7188.5327453715345;7215.783526494213;7586.506877052974;7595.810104747205;7601.923980760122;7603.619819008917;7605.809854753676;4858.198397264412;4865.829695960766;4868.464468908346;4875.756212189447;4877.561019508119;7131.679074441767;7223.747168849065;7246.565206087652;7278.818029549304;7291.161516425467;7045.823854403681;7076;7076.2923707628825;7078.469114816512;7078.610676412847;7002.964985175042;7010.404115650227;7010.789676309515;7021.368076873106;7028.332308430691;6855.280195579592;6931.584104953719;6931.82670433223;6939.965300173669;6950.131233595801;6869.210040845367;7091.184513780981;7094.077769889881;7097.82255443618;7098.467614929004;6796.18445786489;6911.3779759821855;6950.06174166481;6961.408280296231;6966.12923384577 09:26:01 INFO - PROCESS | 27991 | |5;yui.html;829.6847198064735;863.6070587882514;873.1661263493364;922.9353945223833;930.469632309583;15508.22458877056;15554.611134721637;15636.687266254668;15649.45226917058;15789.131597762118;13639;13740.106893051945;13749.862501374982;13750.243736594482;13760;763.0576238345639;909.05912380686;926.5737760630118;930.1256818590537;931.2782593490066;902.4720538484994;907.7322189953946;914.7484441778497;917.614601867214;919.9402038867486;962.0956301077;963.3064193780502;969.7527130581692;972.1056627902311;972.3436680240844;959.8320293948601;965.5075911285224;967.2213867836389;967.6226271754057;967.7338731848728;672.4385138409434;693.628908533932;706.3678008182699;707.6815433055145;711.3349018667562;14685.045472044283;14715.852841471662;14730.705385892223;14772.630684232872;14776.704465910729;12978.610641680765;13184.604461866064;13396.196228226338;13401.46394144233;13452;11192.944035279854;11323.43382830855;11423.428828558539;11523.19337646365;11614.477348519336;3855.5951625079524;3883.0680636647285;3905.1994341159993;3923.8626648067466;3950.0519875230025;53949.73025134849;54051.72974135104;54628.72685636586;54680;54693.453065469235;11179.161562882817;11778.587749428729;11813.40932953349;12025.819612705816;12126.696832579257;20686.58626827455;20779.584408311748;20960.895195523924;21284.36146915595;21289;8046.758597242092;8119.188081191834;8273.958630206811;8436.45163064399;8635.438696484709;4990.8752281193265;5115.565176959925;5156.071907056766;5157.63896527247;5202.479752024768;3498.5626796650417;3520.77114987525;3523.436250200007;3532.3994920863515;3548.254866478017;629.6505439481132;649.7855707616475;651.5862427358567;656.2485953583121;666.4068978609042;714.3392362065069;748.7678819565843;765.9885101723479;797.9401544884041;819.6762278899802;9086.591103400231;9266.397684150508;9487.193588544913;9707.369021013612;9872.210223182128;798.6525861250375;806.4113197365956;808.6361137488036;812.772423721359;819.8811172379972;4428.247197976351;4515.571020753023;4555.886102847389;4575.725456472623;4635.096156249499;57493;57756.4224357751;58076.70961645165;58229;59742.70128649329;48327;49059.50940490621;49123.50876491261;49232.261516077284;49284;43871.780641097226;44743;45220.54779452163;47307;49328.99999999928;9311.208547273558;9324;9499.335046546676;9725;9946.403215807075;35874;37494.250114998096;37933.62066379301;38161.04597385087;39194.41208381819;42938.57061429346;43415.78292108519;46927.76536117298;47897.28154077622;48254.75872620614;12068.879311207127;12453.875461245272;12519;12701.4284357206;12760.234385936874;12898;13388.263645499592;13996.580102596938;14311.284435777961;14481.782773258621;13668;13913.652158696113;13983.860161398256;14156.362963666867;14289.142651440947;13205.273709946045;13286.468541258242;13759.38082786257;14403.78394324065;14495.275236237934;11542.480588373375;12743.426545805276;13007.869921300666;13096.803547946978;13952.441902324199;11040;11226.158038147334;11298.661040168809;11710.531578736754;11748.118891083373;11393.829092563785;11711.590094346657;11743;11865.288082715064;11881.702957425789 09:26:01 INFO - PROCESS | 27991 | __end_tp_report 09:26:01 INFO - PROCESS | 27991 | __start_cc_report 09:26:01 INFO - PROCESS | 27991 | _x_x_mozilla_cycle_collect,325 09:26:01 INFO - PROCESS | 27991 | __end_cc_report 09:26:01 INFO - PROCESS | 27991 | __startTimestamp1463070361754__endTimestamp 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | ------- Summary: start ------- 09:26:01 INFO - PROCESS | 27991 | Number of tests: 6 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | [#0] dojo.html Cycles:165 Average:5510.39 Median:5734.31 stddev:611.89 (10.7%) stddev-sans-first:590.22 09:26:01 INFO - PROCESS | 27991 | Values: 3367.2 3375.8 3397.7 3412.2 3417.3 5458.9 5471.0 5478.3 5508.9 5511.5 5455.8 5468.6 5472.1 5489.5 5526.0 4972.0 4986.6 4997.0 5054.8 5073.2 4981.8 5064.0 5071.7 5084.9 5103.5 5063.7 5066.8 5073.6 5109.0 5170.9 4984.4 4987.6 4999.7 5014.1 5022.4 4898.2 4901.4 4936.6 4966.7 4972.2 5349.2 5396.9 5397.9 5411.1 5468.2 5854.9 5903.9 5924.8 5931.5 5941.3 5949.9 5978.0 5979.6 5980.0 5988.6 5413.6 5492.1 5590.4 5607.6 5660.6 6073.8 6078.6 6084.7 6095.6 6098.8 5785.0 5828.8 5832.0 5833.9 5840.1 5974.8 6029.2 6036.6 6050.9 6072.1 5876.2 5905.9 5935.6 5958.0 5968.3 5717.2 5889.6 5916.8 5960.6 5990.3 4540.7 4557.0 4562.7 4571.3 4593.4 4077.2 4090.0 4109.8 4121.8 4127.7 5510.2 5535.0 5559.1 5756.3 5772.1 5816.1 5941.0 5998.7 6012.4 6049.3 5723.7 5744.8 5750.2 5750.3 5751.1 4925.7 4953.1 4981.7 4985.6 5004.5 6160.1 6200.3 6205.7 6211.3 6220.2 5972.4 5999.2 6015.9 6034.8 6040.0 6109.3 6117.5 6193.4 6217.0 6221.0 5820.7 5821.8 5827.9 5834.6 5874.1 5755.0 5869.3 5869.8 5873.7 5881.7 5713.1 5738.7 5768.8 5769.0 5820.5 5684.4 5728.2 5760.4 5771.2 5774.1 5584.6 5607.1 5640.9 5668.2 5695.4 5823.1 5833.6 5868.5 5882.9 5910.7 5688.0 5691.7 5693.7 5722.5 5734.3 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | [#1] ext.html Cycles:180 Average:60058.07 Median:43416.24 stddev:113764.92 (262.0%) stddev-sans-first:113996.67 09:26:01 INFO - PROCESS | 27991 | Values: 669.5 669.5 673.2 726.5 735.2 39371.6 40443.2 40660.0 40709.6 40857.6 43287.4 43376.1 43674.6 43698.3 44102.0 8845.2 8962.2 9000.1 9002.7 9012.9 8718.2 8858.1 8872.6 8876.6 8879.2 9123.8 9150.5 9152.1 9157.0 9216.4 9038.1 9145.3 9146.9 9171.4 9176.4 9126.7 9190.9 9217.2 9221.6 9232.8 40382.8 41115.6 41117.0 41211.8 41267.8 3822.3 4013.0 4087.9 4426.4 4680.2 32826.0 32934.0 33225.5 33478.3 34362.0 4546.5 4596.4 4620.8 4649.4 4671.2 313067.0 316470.0 317815.0 318324.0 320107.0 63332.4 63345.7 63637.0 63703.0 63782.4 69534.3 71224.0 73557.6 73575.6 73609.3 17561.1 17797.6 17871.6 17895.2 17898.5 13321.5 13517.9 13525.8 13540.0 13577.1 20711.5 20766.3 20891.1 20947.0 20957.3 7696.8 7954.1 8016.6 8049.2 8284.5 1101.6 1107.0 1112.0 1196.1 1288.0 33470.5 33891.5 34007.7 34224.7 34291.4 1217.0 1246.5 1285.1 1333.0 1367.4 17065.5 17242.7 17425.8 17459.0 17763.2 477972.0 491500.0 523449.0 534558.0 558482.0 57797.7 58708.7 58934.4 59024.0 59098.7 1503.6 1505.3 1517.6 1523.6 1633.2 33938.8 34302.0 34468.5 34561.3 34568.1 55912.4 56338.4 56733.4 56760.0 56848.7 425460.0 429766.0 432439.0 434692.0 435073.0 31358.1 31916.2 32055.5 32084.0 32096.0 50983.2 51375.5 51974.0 52218.2 52607.5 42797.4 43456.3 43641.0 43685.3 43884.3 43185.0 43512.1 43700.0 43839.6 43843.8 43338.8 44383.8 44631.8 44686.0 44686.3 36525.0 37189.3 37380.0 37480.3 37935.4 28650.0 29558.9 29584.3 29848.3 30148.2 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | [#2] jquery.html Cycles:180 Average:20110.49 Median:2046.52 stddev:33601.84 (1641.9%) stddev-sans-first:33663.54 09:26:01 INFO - PROCESS | 27991 | Values: 408.7 416.2 421.7 425.5 432.1 18502.6 18933.2 19117.7 19605.8 20757.8 19815.9 19997.6 20259.8 20268.3 20333.9 5630.7 5710.4 5809.3 5836.9 5906.0 5710.7 5753.7 5764.1 5765.3 5819.0 5624.3 5697.5 5704.4 5743.8 5874.9 5726.3 5769.2 5810.8 5823.8 5858.3 5221.2 5224.0 5239.2 5254.2 5256.0 23156.3 23506.9 23982.4 24051.4 24076.0 2423.4 2578.9 2698.6 2817.4 2911.5 14721.8 14738.8 14827.6 15165.1 15167.8 2033.5 2045.4 2047.6 2124.2 2124.9 78998.6 80390.6 80958.0 81306.0 81427.0 10308.3 10495.4 10517.9 10730.1 10731.3 13997.6 14016.7 14099.3 14112.7 14207.7 8160.7 8175.3 8281.5 8344.0 8379.2 8071.4 8163.3 8173.6 8222.7 8233.1 6650.9 6671.0 6676.6 6722.7 6730.0 1873.7 1909.9 1923.6 1928.2 1941.2 1014.8 1098.2 1124.4 1180.7 1207.2 19239.7 19285.7 19627.9 19728.7 20169.1 1082.5 1142.8 1171.8 1187.7 1197.7 11424.1 11441.2 11468.4 11500.9 11566.8 185042.0 186125.0 187035.0 188623.0 188970.0 66871.7 71362.0 72934.6 75312.2 81788.6 1097.4 1115.0 1131.8 1162.5 1166.5 17582.7 17889.4 18077.5 18195.5 18371.9 35504.3 35828.5 36549.0 36960.6 37849.4 50227.0 51196.2 51528.7 51633.7 51768.2 8883.5 8985.0 9055.9 9082.8 9153.2 13746.5 13888.9 13981.4 14184.5 14198.7 12154.6 12323.9 12500.3 12656.4 12729.8 11989.2 12168.5 12181.4 12266.4 12460.6 12148.9 12256.9 12307.7 12450.9 12569.4 8556.0 8596.9 8640.4 8702.1 8767.6 11949.3 12053.8 12069.7 12247.7 12259.1 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | [#3] mootools.html Cycles:180 Average:5299.23 Median:4941.38 stddev:2857.98 (57.8%) stddev-sans-first:2852.16 09:26:01 INFO - PROCESS | 27991 | Values: 1556.6 1581.4 1760.3 1862.8 1867.7 6930.6 7508.2 7528.2 7690.5 7709.2 7563.6 7614.1 7615.3 7678.6 7686.8 2173.9 2293.6 2297.0 2306.4 2310.4 2265.1 2285.8 2294.3 2315.7 2325.2 2272.1 2284.1 2316.1 2326.2 2345.0 2295.8 2306.4 2308.4 2318.4 2325.5 2260.9 2263.0 2264.7 2269.0 2285.5 7812.0 7821.5 7837.1 7893.1 7899.6 4685.5 4693.0 4741.6 4741.8 4761.8 3259.4 3298.8 3452.1 3461.7 3488.8 1156.9 1164.6 1201.6 1201.7 1227.2 10844.3 10856.0 10948.3 10965.3 10969.9 4301.4 4305.5 4340.3 4342.1 4353.5 9332.6 9359.0 9361.0 9384.8 9402.6 4974.4 4976.6 4979.8 4981.9 4983.7 4068.1 4449.2 4496.4 4540.1 4569.1 3821.4 3914.1 3928.8 3962.2 4056.7 1235.7 1254.8 1256.8 1277.4 1284.0 941.9 1034.4 1037.6 1042.2 1066.8 5501.4 5509.7 5580.3 5629.7 5633.9 424.1 427.6 433.0 437.6 437.9 4001.8 4001.9 4020.3 4022.7 4082.5 9600.1 9859.5 9989.5 10011.2 10041.7 9620.9 9677.6 9754.0 9781.5 9856.5 7717.1 7718.6 7808.6 7837.6 7847.0 5516.4 5528.3 5600.3 5710.3 5726.3 8556.4 8670.5 8725.2 8810.5 8849.1 8644.5 8674.3 8712.4 8763.1 8798.8 6269.9 6662.1 6822.8 6970.7 7028.8 7402.0 7585.9 7593.5 7597.9 7650.3 6785.4 7017.8 7027.0 7087.0 7117.6 6692.0 6810.5 6954.2 7011.1 7039.8 6302.2 6318.1 6375.1 6548.5 6601.0 4876.3 4877.2 4927.3 5013.5 5072.3 4909.3 4920.8 4955.5 4999.1 5025.0 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | [#4] prototype.html Cycles:180 Average:5878.31 Median:6798.46 stddev:1805.13 (26.6%) stddev-sans-first:1761.61 09:26:01 INFO - PROCESS | 27991 | Values: 336.2 341.4 341.7 344.5 344.9 6497.8 6546.3 6623.2 6674.3 6691.0 6601.2 6655.5 6667.9 6670.2 6705.2 5007.7 5008.4 5009.0 5009.6 5017.0 4998.4 5004.1 5014.9 5015.6 5015.8 4952.8 4957.2 4959.8 4979.6 4980.2 4776.0 4900.3 4966.6 4970.3 4985.1 4298.3 4299.2 4302.3 4318.4 4321.8 6298.6 6316.7 6319.2 6332.6 6343.9 5768.0 5805.0 5811.3 5819.0 5822.7 6934.1 6966.6 6982.4 6987.4 6992.8 4664.5 4811.4 4830.0 4830.1 4830.9 7286.6 7341.4 7371.9 7379.0 7379.7 4959.9 4961.3 4962.3 4962.7 4963.2 5031.9 5033.6 5034.6 5036.6 5049.4 5813.0 5814.8 5816.3 5818.1 5826.7 6844.5 7045.0 7049.5 7055.1 7065.5 1732.3 1767.4 1767.6 1771.4 1775.5 1087.5 1145.4 1151.6 1173.0 1174.3 6800.7 6905.7 6932.7 6956.2 6977.1 7268.8 7307.1 7329.4 7330.5 7333.7 6837.4 6862.9 6864.2 6883.9 6889.2 3884.6 3893.3 3927.9 3933.0 3954.2 7618.9 7619.6 7620.0 7640.9 7640.9 7424.8 7469.0 7494.4 7508.7 7517.3 7603.0 7608.8 7612.2 7619.9 7633.5 7126.8 7228.5 7246.0 7260.8 7287.5 7098.6 7150.1 7178.4 7188.5 7215.8 7586.5 7595.8 7601.9 7603.6 7605.8 4858.2 4865.8 4868.5 4875.8 4877.6 7131.7 7223.7 7246.6 7278.8 7291.2 7045.8 7076.0 7076.3 7078.5 7078.6 7003.0 7010.4 7010.8 7021.4 7028.3 6855.3 6931.6 6931.8 6940.0 6950.1 6869.2 7091.2 7094.1 7097.8 7098.5 6796.2 6911.4 6950.1 6961.4 6966.1 09:26:01 INFO - PROCESS | 27991 | 09:26:01 INFO - PROCESS | 27991 | [#5] yui.html Cycles:180 Average:14863.48 Median:24868.06 stddev:16293.37 (65.5%) stddev-sans-first:16304.99 09:26:01 INFO - PROCESS | 27991 | Values: 829.7 863.6 873.2 922.9 930.5 15508.2 15554.6 15636.7 15649.5 15789.1 13639.0 13740.1 13749.9 13750.2 13760.0 763.1 909.1 926.6 930.1 931.3 902.5 907.7 914.7 917.6 919.9 962.1 963.3 969.8 972.1 972.3 959.8 965.5 967.2 967.6 967.7 672.4 693.6 706.4 707.7 711.3 14685.0 14715.9 14730.7 14772.6 14776.7 12978.6 13184.6 13396.2 13401.5 13452.0 11192.9 11323.4 11423.4 11523.2 11614.5 3855.6 3883.1 3905.2 3923.9 3950.1 53949.7 54051.7 54628.7 54680.0 54693.5 11179.2 11778.6 11813.4 12025.8 12126.7 20686.6 20779.6 20960.9 21284.4 21289.0 8046.8 8119.2 8274.0 8436.5 8635.4 4990.9 5115.6 5156.1 5157.6 5202.5 3498.6 3520.8 3523.4 3532.4 3548.3 629.7 649.8 651.6 656.2 666.4 714.3 748.8 766.0 797.9 819.7 9086.6 9266.4 9487.2 9707.4 9872.2 798.7 806.4 808.6 812.8 819.9 4428.2 4515.6 4555.9 4575.7 4635.1 57493.0 57756.4 58076.7 58229.0 59742.7 48327.0 49059.5 49123.5 49232.3 49284.0 43871.8 44743.0 45220.5 47307.0 49329.0 9311.2 9324.0 9499.3 9725.0 9946.4 35874.0 37494.3 37933.6 38161.0 39194.4 42938.6 43415.8 46927.8 47897.3 48254.8 12068.9 12453.9 12519.0 12701.4 12760.2 12898.0 13388.3 13996.6 14311.3 14481.8 13668.0 13913.7 13983.9 14156.4 14289.1 13205.3 13286.5 13759.4 14403.8 14495.3 11542.5 12743.4 13007.9 13096.8 13952.4 11040.0 11226.2 11298.7 11710.5 11748.1 11393.8 11711.6 11743.0 11865.3 11881.7 09:26:01 INFO - PROCESS | 27991 | -------- Summary: end -------- 09:26:01 INFO - PROCESS | 27991 | 09:26:02 INFO - TEST-INFO | 27991: exit 0 09:26:02 INFO - TEST-OK | dromaeo_css | took 1108415ms 09:26:02 INFO - TEST-START | kraken 09:26:02 INFO - operating with platform_type : linux_ 09:26:02 INFO - Initialising browser for kraken test... 09:26:02 INFO - TEST-INFO | started process 28238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp048Bcm/profile http://localhost:37989/getInfo.html) 09:26:06 INFO - PROCESS | 28238 | 09:26:06 INFO - PROCESS | 28238 | (process:28314): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:26:06 INFO - PROCESS | 28238 | __metrics Screen width/height:1600/1200 09:26:06 INFO - PROCESS | 28238 | colorDepth:24 09:26:06 INFO - PROCESS | 28238 | Browser inner width/height: 1024/697 09:26:06 INFO - PROCESS | 28238 | __metrics 09:26:07 ERROR - PROCESS | 28238 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:26:08 INFO - TEST-INFO | 28238: exit 0 09:26:08 INFO - Browser initialized. 09:26:08 INFO - Running cycle 1/1 for kraken test... 09:26:08 INFO - TEST-INFO | started process 28365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp048Bcm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:09 INFO - PROCESS | 28365 | 09:26:09 INFO - PROCESS | 28365 | (process:28431): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:26:19 INFO - PROCESS | 28365 | RSS: Main: 152444928 09:26:19 INFO - PROCESS | 28365 | 09:26:22 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37989/tests/kraken/driver.html?testName=audio-beat-detection) 09:26:23 INFO - PROCESS | 28365 | RSS: Main: 156958720 09:26:23 INFO - PROCESS | 28365 | 09:26:25 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37989/tests/kraken/driver.html?testName=audio-dft) 09:26:26 INFO - PROCESS | 28365 | RSS: Main: 156954624 09:26:26 INFO - PROCESS | 28365 | 09:26:29 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37989/tests/kraken/driver.html?testName=audio-fft) 09:26:30 INFO - PROCESS | 28365 | RSS: Main: 157085696 09:26:30 INFO - PROCESS | 28365 | 09:26:32 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37989/tests/kraken/driver.html?testName=audio-oscillator) 09:26:32 INFO - PROCESS | 28365 | RSS: Main: 157249536 09:26:32 INFO - PROCESS | 28365 | 09:26:35 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:35 INFO - PROCESS | 28365 | RSS: Main: 157265920 09:26:35 INFO - PROCESS | 28365 | 09:26:38 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37989/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:39 INFO - PROCESS | 28365 | RSS: Main: 156938240 09:26:39 INFO - PROCESS | 28365 | 09:26:42 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37989/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:43 INFO - PROCESS | 28365 | RSS: Main: 157855744 09:26:43 INFO - PROCESS | 28365 | 09:26:46 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37989/tests/kraken/driver.html?testName=json-parse-financial) 09:26:46 INFO - PROCESS | 28365 | RSS: Main: 157073408 09:26:46 INFO - PROCESS | 28365 | 09:26:48 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:48 INFO - PROCESS | 28365 | RSS: Main: 157487104 09:26:48 INFO - PROCESS | 28365 | 09:26:50 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:51 INFO - PROCESS | 28365 | RSS: Main: 157122560 09:26:51 INFO - PROCESS | 28365 | 09:26:53 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:53 INFO - PROCESS | 28365 | RSS: Main: 157683712 09:26:53 INFO - PROCESS | 28365 | 09:26:56 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:56 INFO - PROCESS | 28365 | RSS: Main: 157765632 09:26:56 INFO - PROCESS | 28365 | 09:26:59 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:00 INFO - PROCESS | 28365 | RSS: Main: 157818880 09:27:00 INFO - PROCESS | 28365 | 09:27:01 INFO - PROCESS | 28365 | Cycle 1(1): loaded http://localhost:37989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37989/tests/kraken/driver.html?testName=ai-astar) 09:27:02 INFO - PROCESS | 28365 | RSS: Main: 159244288 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | __start_tp_report 09:27:02 INFO - PROCESS | 28365 | _x_x_mozilla_page_load 09:27:02 INFO - PROCESS | 28365 | _x_x_mozilla_page_load_details 09:27:02 INFO - PROCESS | 28365 | |i|pagename|runs| 09:27:02 INFO - PROCESS | 28365 | |0;ai-astar;108;111;104;110;111;111;101;113;111;111 09:27:02 INFO - PROCESS | 28365 | |1;audio-beat-detection;157;132;160;175;131;155;146;127;181;132 09:27:02 INFO - PROCESS | 28365 | |2;audio-dft;163;164;164;162;161;162;166;161;161;164 09:27:02 INFO - PROCESS | 28365 | |3;audio-fft;75;79;73;176;76;79;76;76;183;77 09:27:02 INFO - PROCESS | 28365 | |4;audio-oscillator;92;92;161;95;93;91;157;91;93;152 09:27:02 INFO - PROCESS | 28365 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;118;117 09:27:02 INFO - PROCESS | 28365 | |6;imaging-darkroom;146;148;148;149;149;146;146;147;145;147 09:27:02 INFO - PROCESS | 28365 | |7;imaging-desaturate;96;95;96;95;95;95;94;95;95;95 09:27:02 INFO - PROCESS | 28365 | |8;json-parse-financial;53;54;56;55;55;54;56;69;55;54 09:27:02 INFO - PROCESS | 28365 | |9;json-stringify-tinderbox;57;57;58;59;58;56;57;58;58;59 09:27:02 INFO - PROCESS | 28365 | |10;stanford-crypto-aes;74;72;80;80;73;73;87;74;76;73 09:27:02 INFO - PROCESS | 28365 | |11;stanford-crypto-ccm;117;117;124;112;114;116;124;112;137;137 09:27:02 INFO - PROCESS | 28365 | |12;stanford-crypto-pbkdf2;161;168;162;164;158;160;166;158;159;158 09:27:02 INFO - PROCESS | 28365 | |13;stanford-crypto-sha256-iterative;67;66;66;68;67;66;68;68;66;67 09:27:02 INFO - PROCESS | 28365 | __end_tp_report 09:27:02 INFO - PROCESS | 28365 | __start_cc_report 09:27:02 INFO - PROCESS | 28365 | _x_x_mozilla_cycle_collect,840 09:27:02 INFO - PROCESS | 28365 | __end_cc_report 09:27:02 INFO - PROCESS | 28365 | __startTimestamp1463070422230__endTimestamp 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | ------- Summary: start ------- 09:27:02 INFO - PROCESS | 28365 | Number of tests: 14 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.75 (3.4%) stddev-sans-first:3.96 09:27:02 INFO - PROCESS | 28365 | Values: 108.0 111.0 104.0 110.0 111.0 111.0 101.0 113.0 111.0 111.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.00 stddev:19.18 (12.3%) stddev-sans-first:20.16 09:27:02 INFO - PROCESS | 28365 | Values: 157.0 132.0 160.0 175.0 131.0 155.0 146.0 127.0 181.0 132.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.50 stddev:1.69 (1.0%) stddev-sans-first:1.79 09:27:02 INFO - PROCESS | 28365 | Values: 163.0 164.0 164.0 162.0 161.0 162.0 166.0 161.0 161.0 164.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#3] audio-fft Cycles:10 Average:97.00 Median:76.00 stddev:43.55 (57.3%) stddev-sans-first:45.46 09:27:02 INFO - PROCESS | 28365 | Values: 75.0 79.0 73.0 176.0 76.0 79.0 76.0 76.0 183.0 77.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:92.00 stddev:31.12 (33.8%) stddev-sans-first:32.18 09:27:02 INFO - PROCESS | 28365 | Values: 92.0 92.0 161.0 95.0 93.0 91.0 157.0 91.0 93.0 152.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:27:02 INFO - PROCESS | 28365 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.37 (0.9%) stddev-sans-first:1.39 09:27:02 INFO - PROCESS | 28365 | Values: 146.0 148.0 148.0 149.0 149.0 146.0 146.0 147.0 145.0 147.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 09:27:02 INFO - PROCESS | 28365 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:4.63 (8.4%) stddev-sans-first:4.77 09:27:02 INFO - PROCESS | 28365 | Values: 53.0 54.0 56.0 55.0 55.0 54.0 56.0 69.0 55.0 54.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 09:27:02 INFO - PROCESS | 28365 | Values: 57.0 57.0 58.0 59.0 58.0 56.0 57.0 58.0 58.0 59.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.00 stddev:4.76 (6.3%) stddev-sans-first:4.98 09:27:02 INFO - PROCESS | 28365 | Values: 74.0 72.0 80.0 80.0 73.0 73.0 87.0 74.0 76.0 73.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.50 stddev:9.42 (7.8%) stddev-sans-first:9.88 09:27:02 INFO - PROCESS | 28365 | Values: 117.0 117.0 124.0 112.0 114.0 116.0 124.0 112.0 137.0 137.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:3.57 (2.2%) stddev-sans-first:3.78 09:27:02 INFO - PROCESS | 28365 | Values: 161.0 168.0 162.0 164.0 158.0 160.0 166.0 158.0 159.0 158.0 09:27:02 INFO - PROCESS | 28365 | 09:27:02 INFO - PROCESS | 28365 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 09:27:02 INFO - PROCESS | 28365 | Values: 67.0 66.0 66.0 68.0 67.0 66.0 68.0 68.0 66.0 67.0 09:27:02 INFO - PROCESS | 28365 | -------- Summary: end -------- 09:27:02 INFO - PROCESS | 28365 | 09:27:03 INFO - TEST-INFO | 28365: exit 0 09:27:03 INFO - TEST-OK | kraken | took 60738ms 09:27:03 INFO - SUITE-END | took 1169s 09:27:03 INFO - Completed test suite (00:19:29) 09:27:03 INFO - javascript benchmark 09:27:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.2255381262307, 3375.848086836092, 3397.728181745459, 3412.232247744258, 3417.2652879630873, 5458.890822183554, 5471.015217260897, 5478.342598888139, 5508.889822203553, 5511.53151982081, 5455.754491047903, 5468.644538105021, 5472.1244600863865, 5489.478499542547, 5525.972370138144, 4971.975140124295, 4986.626003049786, 4997.0, 5054.797808087672, 5073.188289873621, 4981.825636102737, 5064.0, 5071.7210553419545, 5084.872878178038, 5103.4896510349035, 5063.721495317756, 5066.771995260222, 5073.619478539106, 5108.974455127719, 5170.896582068356, 4984.352034235562, 4987.576056035241, 4999.675021123651, 5014.1225285575065, 5022.372203474566, 4898.167311557044, 4901.43633482147, 4936.6297527685565, 4966.677165984235, 4972.154733695281, 5349.197620356938, 5396.865078373033, 5397.946020539784, 5411.053065713484, 5468.179773034037, 5854.912176317316, 5903.940960590382, 5924.763009479616, 5931.525477961753, 5941.287045554518, 5949.940500594982, 5977.970110149421, 5979.5515336349945, 5980.0, 5988.640681559121, 5413.566914646858, 5492.148716948879, 5590.413006634326, 5607.55139588836, 5660.632058916157, 6073.75704971805, 6078.6048906820915, 6084.695765211722, 6095.603785753912, 6098.847528811726, 5784.971075144597, 5828.795992140254, 5832.037713777179, 5833.912491312633, 5840.065589505659, 5974.790882319098, 6029.155918171459, 6036.63780173191, 6050.909236361458, 6072.149899014142, 5876.236089308448, 5905.911411328833, 5935.554833387513, 5958.046712525975, 5968.283805943314, 5717.17101020358, 5889.5877288590245, 5916.792912248051, 5960.612560183574, 5990.28116625999, 4540.727556346564, 4557.043020965634, 4562.657800664963, 4571.337156112345, 4593.379893714306, 4077.1641813428178, 4089.97955010229, 4109.773962432035, 4121.835126594962, 4127.669786417079, 5510.201020851954, 5535.0, 5559.138333558305, 5756.309242890796, 5772.105323674838, 5816.098504731774, 5941.0, 5998.70006499682, 6012.39876012404, 6049.304330002018, 5723.685197314105, 5744.770209191669, 5750.2237197978575, 5750.30996280449, 5751.051076572402, 4925.729084900365, 4953.083679519228, 4981.701097934136, 4985.601151907838, 5004.549590536796, 6160.1375807387, 6200.348963358872, 6205.6586887721605, 6211.3478084801345, 6220.191375121296, 5972.372900845522, 5999.220101386792, 6015.939840601538, 6034.788782392595, 6040.003399439043, 6109.313572000111, 6117.510599151969, 6193.4425901669065, 6216.968915155395, 6221.035739460391, 5820.679862607597, 5821.76712931478, 5827.854303642443, 5834.591578589458, 5874.118882167709, 5754.971225143848, 5869.295684517885, 5869.8239052828485, 5873.676947767914, 5881.735321910439, 5713.114467257582, 5738.655680659173, 5768.826935191951, 5769.0481070624555, 5820.476157145878, 5684.374718781013, 5728.169415434655, 5760.366359700346, 5771.249737534094, 5774.105013722879, 5584.636998595079, 5607.102863541813, 5640.915386269291, 5668.234788303526, 5695.430456954271, 5823.068309070529, 5833.649981001154, 5868.471837534642, 5882.911756323744, 5910.734016969161, 5688.033034384247, 5691.7438715257085, 5693.658380497183, 5722.484976352148, 5734.311882574118], "value": 5471.242490452741, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.4577392312227, 669.4844969373579, 673.168636733634, 726.5277569579772, 735.1986334894965, 39371.60628393715, 40443.191136177295, 40660.0, 40709.592904070916, 40857.59142408575, 43287.35068973968, 43376.13247735043, 43674.563254367444, 43698.34452483215, 44102.0, 8845.159709827556, 8962.238209752146, 9000.144986226298, 9002.684906028291, 9012.909870901305, 8718.17177368149, 8858.114188581123, 8872.645094196258, 8876.556172191396, 8879.156480134408, 9123.771905702377, 9150.496722680284, 9152.084791520861, 9157.0, 9216.354855160109, 9038.141376569249, 9145.268378529734, 9146.86279705805, 9171.449713017173, 9176.357654964155, 9126.680566180152, 9190.908090919072, 9217.216536594398, 9221.631134754602, 9232.769180770467, 40382.79808600938, 41115.58884411177, 41117.0, 41211.793941030104, 41267.7936610315, 3822.311983842907, 4012.959870401288, 4087.9386809197886, 4426.402435671175, 4680.157571637104, 32826.0, 32934.0, 33225.501617475755, 33478.33043339144, 34362.0, 4546.499885012646, 4596.448426188846, 4620.8151673933, 4649.3970968740705, 4671.182543054986, 313067.0, 316470.0, 317814.9999999977, 318324.0, 320107.0, 63332.36667633357, 63345.683271583344, 63637.04544431837, 63703.0, 63782.36217637857, 69534.30465695278, 71224.0, 73557.63221183966, 73575.63212183905, 73609.26390736131, 17561.12194390301, 17797.644047118985, 17871.642567148843, 17895.194716237802, 17898.463046108638, 13321.467141314433, 13517.86482135166, 13525.797113043312, 13540.0, 13577.11748736329, 20711.482212944495, 20766.273180438613, 20891.059902304434, 20947.0, 20957.26649567258, 7696.807579810549, 7954.125046244909, 8016.599170041592, 8049.235322644339, 8284.544350060683, 1101.5758932810925, 1106.980013961016, 1111.9888801112047, 1196.1088988703298, 1287.9742405151844, 33470.497942530885, 33891.491627625604, 34007.65992340094, 34224.657753422645, 34291.43286747771, 1216.9513219471298, 1246.501399440213, 1285.1068507387276, 1332.9600111996656, 1367.407304126129, 17065.488035358958, 17242.741358879626, 17425.82574174242, 17459.0, 17763.20065597051, 477972.0, 491500.0, 523449.0, 534558.0, 558482.0, 57797.71101144551, 58708.706456467444, 58934.41065589375, 59024.0, 59098.704506478054, 1503.5940296120204, 1505.284989629917, 1517.6433538118533, 1523.581015220801, 1633.1670847867672, 33938.830305848314, 34302.0, 34468.48297275593, 34561.30877382388, 34568.13579660529, 55912.44087559235, 56338.43661563496, 56733.432665672815, 56760.0, 56848.715756420956, 425460.0, 429766.0, 432439.0, 434692.0, 435073.0, 31358.05925822229, 31916.24460654686, 32055.519167212045, 32084.0, 32096.0, 50983.23525147051, 51375.48624513707, 51974.0, 52218.21672674989, 52607.47392526179, 42797.35803963005, 43456.34815477707, 43641.0, 43685.344719828594, 43884.341734874644, 43185.0, 43512.12975740404, 43700.0, 43839.56160438355, 43843.78078109589, 43338.78330608327, 44383.77808111068, 44631.776841115585, 44686.0, 44686.3297050551, 36525.0, 37189.25621487609, 37380.0, 37480.250394992494, 37935.43096853494, 28650.0, 29558.852205739695, 29584.260393490335, 29848.25379365533, 30148.24629384283], "value": 21258.353409810246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.7363650445462, 416.15312838373916, 421.65424352031346, 425.4979124632933, 432.1098537013752, 18502.629947401045, 18933.242670293188, 19117.71323430148, 19605.803941960578, 20757.792422075774, 19815.900920495376, 19997.60004799907, 20259.79740202601, 20268.29060982866, 20333.898330508364, 5630.7184640768, 5710.400407957167, 5809.2738407699035, 5836.941630583704, 5905.995980683273, 5710.685912274823, 5753.741081651315, 5764.135379693038, 5765.308163020443, 5819.039858423355, 5624.325080990287, 5697.4587414195585, 5704.372519022904, 5743.827685169452, 5874.9118763218585, 5726.284214473191, 5769.16347129666, 5810.767569297244, 5823.796167134173, 5858.297004359483, 5221.216817477409, 5224.0, 5239.187925871496, 5254.185601231777, 5256.027634887558, 23156.3053108407, 23506.882465587732, 23982.40043998914, 24051.39871503209, 24076.0, 2423.4062654649547, 2578.8839502222445, 2698.6491756071587, 2817.394260234039, 2911.4759343318196, 14721.779173312409, 14738.778918316233, 14827.555173344817, 15165.09009459436, 15167.772483412758, 2033.522122301258, 2045.4375046862083, 2047.6109539187655, 2124.2034237161065, 2124.904379302935, 78998.6050069746, 80390.5980470094, 80958.0, 81306.0, 81427.0, 10308.32995855267, 10495.422751748727, 10517.9474102629, 10730.141588672888, 10731.302465339728, 13997.580072597839, 14016.71966560663, 14099.295035248197, 14112.71774564503, 14207.71584568303, 8160.714374996846, 8175.264226219669, 8281.54451505173, 8344.0, 8379.203975622306, 8071.434999549975, 8163.3061189798345, 8173.591320433955, 8222.72547755099, 8233.053198882086, 6650.90023649636, 6670.966645166744, 6676.599404035774, 6722.66386680664, 6730.0, 1873.7189421586597, 1909.9236030558623, 1923.5768131011155, 1928.23834585338, 1941.213808407597, 1014.7564584499667, 1098.1653943003375, 1124.4377811094453, 1180.6694125644833, 1207.215310048458, 19239.711404328948, 19285.710714339297, 19627.901860490892, 19728.70406943897, 20169.09239084245, 1082.5074591061048, 1142.7771584541101, 1171.83008463774, 1187.679326581818, 1197.7424853656505, 11424.069725118314, 11441.199116061962, 11468.426578671033, 11500.94249528747, 11566.768664626661, 185042.0, 186125.0, 187035.0, 188623.0, 188970.0, 66871.66564167246, 71362.0, 72934.63532682303, 75312.24687753052, 81788.59105704553, 1097.434821067151, 1115.0299239661383, 1131.7623299107279, 1162.4768854015726, 1166.5275563396838, 17582.73625895638, 17889.37387191442, 18077.457676269732, 18195.54511137232, 18371.90814045921, 35504.28991420209, 35828.462573060904, 36549.0, 36960.63039369572, 37849.4322585156, 50227.0, 51196.232056519926, 51528.74235628948, 51633.7418312906, 51768.223476648636, 8883.466991980502, 8985.0, 9055.90944090577, 9082.818343633222, 9153.221976132103, 13746.518871839839, 13888.861111388756, 13981.370838312503, 14184.50354237638, 14198.716025679636, 12154.574589889311, 12323.876761232274, 12500.312482813533, 12656.43046062911, 12729.79932560665, 11989.22070065443, 12168.513259469522, 12181.39093045362, 12266.448009839758, 12460.56388026451, 12148.878511215129, 12256.938715306367, 12307.69230769238, 12450.937745311216, 12569.371531423209, 8556.0, 8596.871046934177, 8640.351973601879, 8702.129787021247, 8767.649294028168, 11949.283043017447, 12053.75892482163, 12069.698257543632, 12247.69380765488, 12259.080568957543], "value": 9308.082088740523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1556.64197234636, 1581.3516458252118, 1760.3486709917333, 1862.841658459031, 1867.69183084791, 6930.584164950106, 7508.249175082489, 7528.247175282469, 7690.538567685936, 7709.226877818105, 7563.621818909046, 7614.086309642837, 7615.276548727862, 7678.577678227695, 7686.769396918087, 2173.913043478259, 2293.552757212344, 2297.0, 2306.4349234437586, 2310.3992961829877, 2265.139247086105, 2285.7942785149335, 2294.3346429535413, 2315.6758053872472, 2325.162941341116, 2272.125231785758, 2284.097781376355, 2316.108298305156, 2326.1974618756585, 2344.988275058622, 2295.8392912496133, 2306.3542208181734, 2308.4459729664927, 2318.374039009475, 2325.5116425550655, 2260.8982595783227, 2263.038208761286, 2264.6942662740485, 2269.024319542596, 2285.4743409015855, 7812.0, 7821.491603045783, 7837.1379148293645, 7893.052833659997, 7899.565523896184, 4685.461171965234, 4692.976535117336, 4741.620670346364, 4741.786619602091, 4761.785719642625, 3259.3970115528705, 3298.818564978925, 3452.085197422685, 3461.7403694723, 3488.825558722079, 1156.9074474042056, 1164.586571767019, 1201.5941348622132, 1201.6755476021426, 1227.1777908801037, 10844.295120817122, 10856.0, 10948.288361256493, 10965.342079475256, 10969.890301096966, 4301.354796780508, 4305.526392096866, 4340.348947657877, 4342.066455712037, 4353.499347575006, 9332.626694932262, 9358.970513243537, 9361.0, 9384.765380865396, 9402.576884040234, 4974.353334066621, 4976.552110310089, 4979.775910084055, 4981.9252711209365, 4983.725895075806, 4068.0846809467635, 4449.243628583084, 4496.4154659894, 4540.137373898949, 4569.086182763461, 3821.3503704370323, 3914.0606254498716, 3928.823202955874, 3962.2471730371135, 4056.7363121397016, 1235.6663700800914, 1254.792959161728, 1256.7926292161874, 1277.3549357574366, 1283.9871601284055, 941.868138460616, 1034.4000479721744, 1037.5538518436992, 1042.2495803021811, 1066.8026415113075, 5501.449855014466, 5509.696966666792, 5580.330360356783, 5629.7185140742795, 5633.915491267634, 424.0733996218273, 427.61514636827104, 432.97185682930507, 437.6389478680102, 437.8839607504014, 4001.7598944063448, 4001.919961600752, 4020.276350256982, 4022.7385219961193, 4082.4896887889013, 9600.135987760996, 9859.50702464874, 9989.450580218012, 10011.249156313306, 10041.698749037541, 9620.855687164698, 9677.612895484102, 9753.951230243803, 9781.46201958885, 9856.45789481571, 7717.073951125901, 7718.614069296513, 7808.570528620867, 7837.568933708587, 7846.9607651962515, 5516.365617953827, 5528.308961379827, 5600.299962504687, 5710.3433105193435, 5726.284214473191, 8556.358273129665, 8670.479771213748, 8725.171108744658, 8810.515421651871, 8849.115088491099, 8644.481331120152, 8674.30605551567, 8712.433691810013, 8763.123687631185, 8798.780030499289, 6269.905951410824, 6662.100616416722, 6822.795316140524, 6970.686319115551, 7028.753993610199, 7401.962990185015, 7585.886211706939, 7593.468457207942, 7597.88603170964, 7650.273224043707, 6785.355391238022, 7017.789466316019, 7027.0, 7086.964565177141, 7117.644117793986, 6691.966540167268, 6810.489213308922, 6954.165500140016, 7011.123609548807, 7039.788806335818, 6302.212223472066, 6318.052292156213, 6375.075614035846, 6548.508861835287, 6601.0, 4876.317315575893, 4877.244027175793, 4927.28554359623, 5013.548780609763, 5072.340595722532, 4909.288153217692, 4920.778564964514, 4955.479674634112, 4999.075171093359, 5025.045241404122], "value": 4285.206002606867, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.1776600057348, 341.4076577138664, 341.69983213871217, 344.5142349287505, 344.86205517792894, 6497.8375540611505, 6546.312637173088, 6623.2383275923285, 6674.332566743317, 6690.966545167274, 6601.174853143357, 6655.500837437187, 6667.933130699089, 6670.166229221348, 6705.195376554808, 5007.674501157431, 5008.398992120941, 5009.023240468092, 5009.649324547283, 5017.0, 4998.425181104183, 5004.124278251292, 5014.924776128361, 5015.623828212881, 5015.824446144386, 4952.826651067214, 4957.231629097478, 4959.82640607577, 4979.576735977446, 4980.153373926423, 4775.952240477585, 4900.338454308659, 4966.553010229079, 4970.304157417964, 4985.077760614298, 4298.290782020963, 4299.183155200533, 4302.290122129845, 4318.373835793824, 4321.762303073329, 6298.622082675009, 6316.652584107872, 6319.178506794134, 6332.620042797447, 6343.936560634427, 5768.048272035109, 5804.970975145097, 5811.27359080115, 5819.0, 5822.650640961556, 6934.063901373351, 6966.616836074014, 6982.371586557183, 6987.406070484015, 6992.79021629352, 4664.510226426244, 4811.422629284508, 4829.951700482985, 4830.106430310404, 4830.9275360869615, 7286.562806231643, 7341.412686985029, 7371.852562948711, 7379.040724705754, 7379.6679149438405, 4959.925601115986, 4961.305417241589, 4962.280469331927, 4962.727050012284, 4963.181075122564, 5031.924521132186, 5033.6476446648385, 5034.572061374751, 5036.64743467961, 5049.444561098277, 5812.9709351452975, 5814.79648212319, 5816.272965879265, 5818.069108942549, 5826.708664566755, 6844.486663500257, 7044.964775176194, 7049.541779784297, 7055.118110236221, 7065.505414620927, 1732.281103342099, 1767.3990843113404, 1767.558110472382, 1771.3800169940675, 1775.5472354549506, 1087.5106202209038, 1145.4043897173424, 1151.5566506894907, 1172.9648110556698, 1174.2543484886987, 6800.727970881208, 6905.689243984033, 6932.688029038705, 6956.165260168812, 6977.058097156921, 7268.818279543054, 7307.086614173229, 7329.377002954702, 7330.450216233698, 7333.74331898381, 6837.38463538274, 6862.9313706863295, 6864.249616347799, 6883.8967415488805, 6889.242183359826, 3884.553276373253, 3893.2992061429213, 3927.8625248116177, 3932.980335098306, 3954.2486927483687, 7618.923810761932, 7619.619019049025, 7620.047494063242, 7640.885386719204, 7640.923590764021, 7424.777256682308, 7468.9626551866895, 7494.40044796415, 7508.662110205054, 7517.323440890346, 7602.961985190039, 7608.80977975544, 7612.162662107164, 7619.923800762032, 7633.465657404039, 7126.750563730245, 7228.530145540523, 7245.963770181115, 7260.818479538054, 7287.4534409920525, 7098.574085554883, 7150.14198296187, 7178.4257259420165, 7188.5327453715345, 7215.783526494213, 7586.506877052974, 7595.810104747205, 7601.923980760122, 7603.619819008917, 7605.809854753676, 4858.198397264412, 4865.829695960766, 4868.464468908346, 4875.756212189447, 4877.561019508119, 7131.679074441767, 7223.747168849065, 7246.565206087652, 7278.818029549304, 7291.161516425467, 7045.823854403681, 7076.0, 7076.2923707628825, 7078.469114816512, 7078.610676412847, 7002.964985175042, 7010.404115650227, 7010.789676309515, 7021.368076873106, 7028.332308430691, 6855.280195579592, 6931.584104953719, 6931.82670433223, 6939.965300173669, 6950.131233595801, 6869.210040845367, 7091.184513780981, 7094.077769889881, 7097.82255443618, 7098.467614929004, 6796.18445786489, 6911.3779759821855, 6950.06174166481, 6961.408280296231, 6966.12923384577], "value": 5277.445026563281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.6847198064735, 863.6070587882514, 873.1661263493364, 922.9353945223833, 930.469632309583, 15508.22458877056, 15554.611134721637, 15636.687266254668, 15649.45226917058, 15789.131597762118, 13639.0, 13740.106893051945, 13749.862501374982, 13750.243736594482, 13760.0, 763.0576238345639, 909.05912380686, 926.5737760630118, 930.1256818590537, 931.2782593490066, 902.4720538484994, 907.7322189953946, 914.7484441778497, 917.614601867214, 919.9402038867486, 962.0956301077, 963.3064193780502, 969.7527130581692, 972.1056627902311, 972.3436680240844, 959.8320293948601, 965.5075911285224, 967.2213867836389, 967.6226271754057, 967.7338731848728, 672.4385138409434, 693.628908533932, 706.3678008182699, 707.6815433055145, 711.3349018667562, 14685.045472044283, 14715.852841471662, 14730.705385892223, 14772.630684232872, 14776.704465910729, 12978.610641680765, 13184.604461866064, 13396.196228226338, 13401.46394144233, 13452.0, 11192.944035279854, 11323.43382830855, 11423.428828558539, 11523.19337646365, 11614.477348519336, 3855.5951625079524, 3883.0680636647285, 3905.1994341159993, 3923.8626648067466, 3950.0519875230025, 53949.73025134849, 54051.72974135104, 54628.72685636586, 54680.0, 54693.453065469235, 11179.161562882817, 11778.587749428729, 11813.40932953349, 12025.819612705816, 12126.696832579257, 20686.58626827455, 20779.584408311748, 20960.895195523924, 21284.36146915595, 21289.0, 8046.758597242092, 8119.188081191834, 8273.958630206811, 8436.45163064399, 8635.438696484709, 4990.8752281193265, 5115.565176959925, 5156.071907056766, 5157.63896527247, 5202.479752024768, 3498.5626796650417, 3520.77114987525, 3523.436250200007, 3532.3994920863515, 3548.254866478017, 629.6505439481132, 649.7855707616475, 651.5862427358567, 656.2485953583121, 666.4068978609042, 714.3392362065069, 748.7678819565843, 765.9885101723479, 797.9401544884041, 819.6762278899802, 9086.591103400231, 9266.397684150508, 9487.193588544913, 9707.369021013612, 9872.210223182128, 798.6525861250375, 806.4113197365956, 808.6361137488036, 812.772423721359, 819.8811172379972, 4428.247197976351, 4515.571020753023, 4555.886102847389, 4575.725456472623, 4635.096156249499, 57493.0, 57756.4224357751, 58076.70961645165, 58229.0, 59742.70128649329, 48327.0, 49059.50940490621, 49123.50876491261, 49232.261516077284, 49284.0, 43871.780641097226, 44743.0, 45220.54779452163, 47307.0, 49328.99999999928, 9311.208547273558, 9324.0, 9499.335046546676, 9725.0, 9946.403215807075, 35874.0, 37494.250114998096, 37933.62066379301, 38161.04597385087, 39194.41208381819, 42938.57061429346, 43415.78292108519, 46927.76536117298, 47897.28154077622, 48254.75872620614, 12068.879311207127, 12453.875461245272, 12519.0, 12701.4284357206, 12760.234385936874, 12898.0, 13388.263645499592, 13996.580102596938, 14311.284435777961, 14481.782773258621, 13668.0, 13913.652158696113, 13983.860161398256, 14156.362963666867, 14289.142651440947, 13205.273709946045, 13286.468541258242, 13759.38082786257, 14403.78394324065, 14495.275236237934, 11542.480588373375, 12743.426545805276, 13007.869921300666, 13096.803547946978, 13952.441902324199, 11040.0, 11226.158038147334, 11298.661040168809, 11710.531578736754, 11748.118891083373, 11393.829092563785, 11711.590094346657, 11743.0, 11865.288082715064, 11881.702957425789], "value": 7076.014273009903, "unit": "score"}], "name": "dromaeo_css", "value": 7466.49992089084, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 110.0, 111.0, 111.0, 101.0, 113.0, 111.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 160.0, 175.0, 131.0, 155.0, 146.0, 127.0, 181.0, 132.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 162.0, 161.0, 162.0, 166.0, 161.0, 161.0, 164.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 73.0, 176.0, 76.0, 79.0, 76.0, 76.0, 183.0, 77.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 161.0, 95.0, 93.0, 91.0, 157.0, 91.0, 93.0, 152.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 149.0, 149.0, 146.0, 146.0, 147.0, 145.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 56.0, 55.0, 55.0, 54.0, 56.0, 69.0, 55.0, 54.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 59.0, 58.0, 56.0, 57.0, 58.0, 58.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 80.0, 80.0, 73.0, 73.0, 87.0, 74.0, 76.0, 73.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 124.0, 112.0, 114.0, 116.0, 124.0, 112.0, 137.0, 137.0], "value": 121.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 168.0, 162.0, 164.0, 158.0, 160.0, 166.0, 158.0, 159.0, 158.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 68.0, 67.0, 66.0, 68.0, 68.0, 66.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1529.0000000000002, "alertThreshold": 2.0}]} 09:27:03 INFO - Return code: 0 09:27:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:27:03 ERROR - # TBPL SUCCESS # 09:27:03 INFO - Running post-action listener: _resource_record_post_action 09:27:03 INFO - Running post-run listener: _resource_record_post_run 09:27:04 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 499347456; Read time: 0; Write time: 487752 09:27:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248631296; Read time: 0; Write time: 300720 09:27:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 250716160; Read time: 0; Write time: 187032 09:27:04 INFO - Running post-run listener: _upload_blobber_files 09:27:04 INFO - Blob upload gear active. 09:27:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:04 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 09:27:04 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'] 09:27:04 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 09:27:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:05 INFO - (blobuploader) - INFO - Done attempting. 09:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:06 INFO - (blobuploader) - INFO - Done attempting. 09:27:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:06 INFO - Return code: 0 09:27:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8131cab601bc0bc2215d355b71a34bcad42c45e5e459c196344806ef224718a270925d3d94967b68a7114544287fb07d8b7e19c8d62d74a66defc36db04a914", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8ceafe8347260788672d4bd63b84256f7b64e1997c28ba1f1f74a4ea51bb728b4c8175a3621206b2d8f8f3a1f7418eb0f48449b2e38975077e11ff43a47d6a9"} 09:27:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:06 INFO - Contents: 09:27:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8131cab601bc0bc2215d355b71a34bcad42c45e5e459c196344806ef224718a270925d3d94967b68a7114544287fb07d8b7e19c8d62d74a66defc36db04a914", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8ceafe8347260788672d4bd63b84256f7b64e1997c28ba1f1f74a4ea51bb728b4c8175a3621206b2d8f8f3a1f7418eb0f48449b2e38975077e11ff43a47d6a9"} 09:27:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:06 INFO - Copying logs to upload dir... 09:27:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.672336 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-12 09:27:06.118017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 09:27:06.123884) ========= 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=62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8131cab601bc0bc2215d355b71a34bcad42c45e5e459c196344806ef224718a270925d3d94967b68a7114544287fb07d8b7e19c8d62d74a66defc36db04a914", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8ceafe8347260788672d4bd63b84256f7b64e1997c28ba1f1f74a4ea51bb728b4c8175a3621206b2d8f8f3a1f7418eb0f48449b2e38975077e11ff43a47d6a9"} build_url:https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/eUf0c2lcRh2nXLIsRSx0gQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8131cab601bc0bc2215d355b71a34bcad42c45e5e459c196344806ef224718a270925d3d94967b68a7114544287fb07d8b7e19c8d62d74a66defc36db04a914", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8ceafe8347260788672d4bd63b84256f7b64e1997c28ba1f1f74a4ea51bb728b4c8175a3621206b2d8f8f3a1f7418eb0f48449b2e38975077e11ff43a47d6a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 09:27:06.151145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:27:06.151665) ========= 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=62c568580acbfdaac3eec7be000001dc-1463069012.650418-731604573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 09:27:06.234839) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 09:27:06.235284) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 09:27:06.235578) ========= ========= Total master_lag: 0.18 =========