builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1464627857.75 results: success (0) buildid: 20160530072146 builduid: 7a54d2f933b14988a6acf83fdac386c2 revision: b2f0425218851914b703b902ed56c6148b37b537 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.753046) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.753710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.754059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.769019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.769357) ========= 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=232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 10:04:18-- 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% 43.6M=0s 2016-05-30 10:04:18 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.886047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.886345) ========= 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=232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015031 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.936295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:17.936649) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b2f0425218851914b703b902ed56c6148b37b537 --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 b2f0425218851914b703b902ed56c6148b37b537 --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=232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 10:04:18,307 truncating revision to first 12 chars 2016-05-30 10:04:18,307 Setting DEBUG logging. 2016-05-30 10:04:18,307 attempt 1/10 2016-05-30 10:04:18,307 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b2f042521885?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 10:04:18,756 unpacking tar archive at: mozilla-aurora-b2f042521885/testing/mozharness/ program finished with exit code 0 elapsedTime=0.801730 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:18.752381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:18.752720) ========= script_repo_revision: b2f0425218851914b703b902ed56c6148b37b537 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:18.753124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:18.753393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:04:18.764911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 10:04:18.765181) ========= /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=232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:19 INFO - MultiFileLogger online at 20160530 10:04:19 in /builds/slave/test 10:04:19 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 10:04:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:19 INFO - {'append_to_log': False, 10:04:19 INFO - 'base_work_dir': '/builds/slave/test', 10:04:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:04:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:19 INFO - 'branch': 'Mozilla-Aurora', 10:04:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:19 INFO - 'config_files': ('talos/linux_config.py',), 10:04:19 INFO - 'default_actions': ('clobber', 10:04:19 INFO - 'read-buildbot-config', 10:04:19 INFO - 'download-and-extract', 10:04:19 INFO - 'populate-webroot', 10:04:19 INFO - 'create-virtualenv', 10:04:19 INFO - 'install', 10:04:19 INFO - 'run-tests'), 10:04:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:19 INFO - 'download_minidump_stackwalk': True, 10:04:19 INFO - 'download_symbols': 'ondemand', 10:04:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:19 INFO - 'installer_path': 'installer.exe', 10:04:19 INFO - 'log_level': 'info', 10:04:19 INFO - 'log_name': 'talos', 10:04:19 INFO - 'log_to_console': True, 10:04:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:19 INFO - 'opt_config_files': (), 10:04:19 INFO - 'pip_index': False, 10:04:19 INFO - 'sps_profile': False, 10:04:19 INFO - 'sps_profile_interval': 0, 10:04:19 INFO - 'suite': 'dromaeojs-e10s', 10:04:19 INFO - 'system_bits': '32', 10:04:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:19 INFO - 'title': 'talos-linux64-ix-025', 10:04:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:19 INFO - 'use_talos_json': True, 10:04:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:19 INFO - 'work_dir': 'build'} 10:04:19 INFO - ##### 10:04:19 INFO - ##### Running clobber step. 10:04:19 INFO - ##### 10:04:19 INFO - Running pre-action listener: _resource_record_pre_action 10:04:19 INFO - Running main action method: clobber 10:04:19 INFO - rmtree: /builds/slave/test/build 10:04:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:19 INFO - Running post-action listener: _resource_record_post_action 10:04:19 INFO - ##### 10:04:19 INFO - ##### Running read-buildbot-config step. 10:04:19 INFO - ##### 10:04:19 INFO - Running pre-action listener: _resource_record_pre_action 10:04:19 INFO - Running main action method: read_buildbot_config 10:04:19 INFO - Using buildbot properties: 10:04:19 INFO - { 10:04:19 INFO - "project": "", 10:04:19 INFO - "product": "firefox", 10:04:19 INFO - "script_repo_revision": "production", 10:04:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:04:19 INFO - "repository": "", 10:04:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:04:19 INFO - "buildid": "20160530072146", 10:04:19 INFO - "pgo_build": "True", 10:04:19 INFO - "basedir": "/builds/slave/test", 10:04:19 INFO - "buildnumber": 306, 10:04:19 INFO - "slavename": "talos-linux64-ix-025", 10:04:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:04:19 INFO - "platform": "ubuntu64_hw", 10:04:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:04:19 INFO - "branch": "mozilla-aurora", 10:04:19 INFO - "repo_path": "releases/mozilla-aurora", 10:04:19 INFO - "revision": "b2f0425218851914b703b902ed56c6148b37b537", 10:04:19 INFO - "stage_platform": "linux64-pgo", 10:04:19 INFO - "builduid": "7a54d2f933b14988a6acf83fdac386c2", 10:04:19 INFO - "slavebuilddir": "test" 10:04:19 INFO - } 10:04:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:04:19 INFO - Running post-action listener: _resource_record_post_action 10:04:19 INFO - ##### 10:04:19 INFO - ##### Running download-and-extract step. 10:04:19 INFO - ##### 10:04:19 INFO - Running pre-action listener: _resource_record_pre_action 10:04:19 INFO - Running main action method: download_and_extract 10:04:19 INFO - mkdir: /builds/slave/test/build/tests 10:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:19 INFO - https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:04:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:04:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:04:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:23 INFO - Downloaded 1361 bytes. 10:04:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:04:23 INFO - Using the following test package requirements: 10:04:23 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:04:23 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:23 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:04:23 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'jsshell-linux-x86_64.zip'], 10:04:23 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:23 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:04:23 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:04:23 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:04:23 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:23 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:04:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:23 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04:23 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')]} 10:04:23 INFO - https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:25 INFO - Downloaded 24136564 bytes. 10:04:25 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'] 10:04:25 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 10:04:27 INFO - Return code: 0 10:04:27 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 10:04:27 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')]} 10:04:27 INFO - https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:29 INFO - Downloaded 24136564 bytes. 10:04:29 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'] 10:04:29 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 10:04:30 INFO - Return code: 0 10:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:30 INFO - https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:04:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:04:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:04:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:31 INFO - Downloaded 10840145 bytes. 10:04:31 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'] 10:04:31 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 10:04:31 INFO - Return code: 0 10:04:31 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')]} 10:04:31 INFO - https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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 10:04:33 INFO - Downloaded 62770358 bytes. 10:04:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:04:33 INFO - mkdir: /builds/slave/test/properties 10:04:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:33 INFO - Contents: 10:04:33 INFO - build_url:https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:04:34 INFO - Running post-action listener: _resource_record_post_action 10:04:34 INFO - Running post-action listener: set_extra_try_arguments 10:04:34 INFO - ##### 10:04:34 INFO - ##### Running populate-webroot step. 10:04:34 INFO - ##### 10:04:34 INFO - Running pre-action listener: _resource_record_pre_action 10:04:34 INFO - Running main action method: populate_webroot 10:04:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:34 INFO - '--tppagecycles', 10:04:34 INFO - '7'], 10:04:34 INFO - 'tests': ['tsvgm']}}, 10:04:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['damp', 'tps']}, 10:04:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'tests': ['damp', 'tps']}, 10:04:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['dromaeo_dom']}, 10:04:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tsvgx', 10:04:34 INFO - 'tsvgr_opacity', 10:04:34 INFO - 'tart', 10:04:34 INFO - 'tscrollx', 10:04:34 INFO - 'cart']}, 10:04:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:34 INFO - 'tsvgr_opacity', 10:04:34 INFO - 'tart', 10:04:34 INFO - 'tscrollx', 10:04:34 INFO - 'cart']}, 10:04:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tp5o']}, 10:04:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'tests': ['tp5o']}, 10:04:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s', 10:04:34 INFO - '--xperf_path', 10:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:34 INFO - 'tests': ['tp5n']}, 10:04:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--xperf_path', 10:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:34 INFO - 'tests': ['tp5n']}}, 10:04:34 INFO - 'talos.zip': {'path': '', 10:04:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:34 INFO - Running post-action listener: _resource_record_post_action 10:04:34 INFO - ##### 10:04:34 INFO - ##### Running create-virtualenv step. 10:04:34 INFO - ##### 10:04:34 INFO - Running pre-action listener: _resource_record_pre_action 10:04:34 INFO - Running main action method: create_virtualenv 10:04:34 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:34 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 10:04:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:34 INFO - Using real prefix '/usr' 10:04:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:36 INFO - Installing pip.................done. 10:04:36 INFO - Return code: 0 10:04:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:36 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 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:36 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 10:04:36 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 10:04:36 INFO - Using env: {'DISPLAY': ':0', 10:04:36 INFO - 'HOME': '/home/cltbld', 10:04:36 INFO - 'LANG': 'en_US.UTF-8', 10:04:36 INFO - 'LANGUAGE': 'en_US:en', 10:04:36 INFO - 'LOGNAME': 'cltbld', 10:04:36 INFO - 'MAIL': '/var/mail/cltbld', 10:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:36 INFO - 'MOZ_NO_REMOTE': '1', 10:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:36 INFO - 'NO_EM_RESTART': '1', 10:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:36 INFO - 'PWD': '/builds/slave/test', 10:04:36 INFO - 'SHELL': '/bin/bash', 10:04:36 INFO - 'SHLVL': '1', 10:04:36 INFO - 'TERM': 'linux', 10:04:36 INFO - 'TMOUT': '86400', 10:04:36 INFO - 'USER': 'cltbld', 10:04:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:36 INFO - '_': '/tools/buildbot/bin/python'} 10:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:37 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 10:04:37 INFO - Cleaning up... 10:04:37 INFO - Return code: 0 10:04:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:04:37 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')]} 10:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:37 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')]} 10:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:37 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 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:37 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 10:04:37 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 10:04:37 INFO - Using env: {'DISPLAY': ':0', 10:04:37 INFO - 'HOME': '/home/cltbld', 10:04:37 INFO - 'LANG': 'en_US.UTF-8', 10:04:37 INFO - 'LANGUAGE': 'en_US:en', 10:04:37 INFO - 'LOGNAME': 'cltbld', 10:04:37 INFO - 'MAIL': '/var/mail/cltbld', 10:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:37 INFO - 'MOZ_NO_REMOTE': '1', 10:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:37 INFO - 'NO_EM_RESTART': '1', 10:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:37 INFO - 'PWD': '/builds/slave/test', 10:04:37 INFO - 'SHELL': '/bin/bash', 10:04:37 INFO - 'SHLVL': '1', 10:04:37 INFO - 'TERM': 'linux', 10:04:37 INFO - 'TMOUT': '86400', 10:04:37 INFO - 'USER': 'cltbld', 10:04:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:37 INFO - '_': '/tools/buildbot/bin/python'} 10:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:37 INFO - Downloading/unpacking psutil>=0.7.1 10:04:37 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 10:04:37 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 10:04:37 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 10:04:37 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 10:04:37 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 10:04:37 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 10:04:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:39 INFO - Installing collected packages: psutil 10:04:39 INFO - Running setup.py install for psutil 10:04:39 INFO - building 'psutil._psutil_linux' extension 10:04:39 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 10:04:39 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 10:04:39 INFO - building 'psutil._psutil_posix' extension 10:04:39 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 10:04:39 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 10:04:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:39 INFO - Successfully installed psutil 10:04:39 INFO - Cleaning up... 10:04:39 INFO - Return code: 0 10:04:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:04:39 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')]} 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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')]} 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:39 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 10:04:39 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 10:04:39 INFO - Using env: {'DISPLAY': ':0', 10:04:39 INFO - 'HOME': '/home/cltbld', 10:04:39 INFO - 'LANG': 'en_US.UTF-8', 10:04:39 INFO - 'LANGUAGE': 'en_US:en', 10:04:39 INFO - 'LOGNAME': 'cltbld', 10:04:39 INFO - 'MAIL': '/var/mail/cltbld', 10:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:39 INFO - 'MOZ_NO_REMOTE': '1', 10:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:39 INFO - 'NO_EM_RESTART': '1', 10:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:39 INFO - 'PWD': '/builds/slave/test', 10:04:39 INFO - 'SHELL': '/bin/bash', 10:04:39 INFO - 'SHLVL': '1', 10:04:39 INFO - 'TERM': 'linux', 10:04:39 INFO - 'TMOUT': '86400', 10:04:39 INFO - 'USER': 'cltbld', 10:04:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:39 INFO - '_': '/tools/buildbot/bin/python'} 10:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:04:41 INFO - Installing collected packages: mozsystemmonitor 10:04:41 INFO - Running setup.py install for mozsystemmonitor 10:04:42 INFO - Successfully installed mozsystemmonitor 10:04:42 INFO - Cleaning up... 10:04:42 INFO - Return code: 0 10:04:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04:42 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')]} 10:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:42 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')]} 10:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:42 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 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:42 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 10:04:42 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 10:04:42 INFO - Using env: {'DISPLAY': ':0', 10:04:42 INFO - 'HOME': '/home/cltbld', 10:04:42 INFO - 'LANG': 'en_US.UTF-8', 10:04:42 INFO - 'LANGUAGE': 'en_US:en', 10:04:42 INFO - 'LOGNAME': 'cltbld', 10:04:42 INFO - 'MAIL': '/var/mail/cltbld', 10:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:42 INFO - 'MOZ_NO_REMOTE': '1', 10:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:42 INFO - 'NO_EM_RESTART': '1', 10:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:42 INFO - 'PWD': '/builds/slave/test', 10:04:42 INFO - 'SHELL': '/bin/bash', 10:04:42 INFO - 'SHLVL': '1', 10:04:42 INFO - 'TERM': 'linux', 10:04:42 INFO - 'TMOUT': '86400', 10:04:42 INFO - 'USER': 'cltbld', 10:04:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:42 INFO - '_': '/tools/buildbot/bin/python'} 10:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:42 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 10:04:42 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 10:04:42 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 10:04:42 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 10:04:42 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 10:04:42 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 10:04:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 INFO - Downloading docopt-0.6.1.tar.gz 10:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:44 INFO - Running setup.py install for blobuploader 10:04:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:45 INFO - Running setup.py install for requests 10:04:45 INFO - Running setup.py install for docopt 10:04:45 INFO - Successfully installed blobuploader requests docopt 10:04:45 INFO - Cleaning up... 10:04:45 INFO - Return code: 0 10:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:45 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 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:45 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 10:04:45 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 10:04:45 INFO - Using env: {'DISPLAY': ':0', 10:04:45 INFO - 'HOME': '/home/cltbld', 10:04:45 INFO - 'LANG': 'en_US.UTF-8', 10:04:45 INFO - 'LANGUAGE': 'en_US:en', 10:04:45 INFO - 'LOGNAME': 'cltbld', 10:04:45 INFO - 'MAIL': '/var/mail/cltbld', 10:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:45 INFO - 'MOZ_NO_REMOTE': '1', 10:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:45 INFO - 'NO_EM_RESTART': '1', 10:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:45 INFO - 'PWD': '/builds/slave/test', 10:04:45 INFO - 'SHELL': '/bin/bash', 10:04:45 INFO - 'SHLVL': '1', 10:04:45 INFO - 'TERM': 'linux', 10:04:45 INFO - 'TMOUT': '86400', 10:04:45 INFO - 'USER': 'cltbld', 10:04:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:45 INFO - '_': '/tools/buildbot/bin/python'} 10:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:45 INFO - Running setup.py (path:/tmp/pip-uqaKOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:45 INFO - Running setup.py (path:/tmp/pip-MK3Bn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:45 INFO - Running setup.py (path:/tmp/pip-yaG2_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:45 INFO - Running setup.py (path:/tmp/pip-cS2qlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:46 INFO - Running setup.py (path:/tmp/pip-6NNBea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:46 INFO - Running setup.py (path:/tmp/pip-DYnW68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:46 INFO - Running setup.py (path:/tmp/pip-KaiG6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:46 INFO - Running setup.py (path:/tmp/pip-sAFTfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:46 INFO - Running setup.py (path:/tmp/pip-sBHb7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:46 INFO - Running setup.py (path:/tmp/pip-jsVVA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:46 INFO - Running setup.py (path:/tmp/pip-5BWLtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:46 INFO - Running setup.py (path:/tmp/pip-NAYrt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:46 INFO - Running setup.py (path:/tmp/pip-Xa5o7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:46 INFO - Running setup.py (path:/tmp/pip-w4UOC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:46 INFO - Running setup.py (path:/tmp/pip-wsCxUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:46 INFO - Running setup.py (path:/tmp/pip-qvNido-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:46 INFO - Running setup.py (path:/tmp/pip-JZl_ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:46 INFO - Running setup.py install for manifestparser 10:04:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Running setup.py install for mozcrash 10:04:47 INFO - Running setup.py install for mozdebug 10:04:47 INFO - Running setup.py install for mozdevice 10:04:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Running setup.py install for mozfile 10:04:47 INFO - Running setup.py install for mozhttpd 10:04:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Running setup.py install for mozinfo 10:04:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Running setup.py install for mozInstall 10:04:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:47 INFO - Running setup.py install for mozleak 10:04:47 INFO - Running setup.py install for mozlog 10:04:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:48 INFO - Running setup.py install for moznetwork 10:04:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:48 INFO - Running setup.py install for mozprocess 10:04:48 INFO - Running setup.py install for mozprofile 10:04:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:48 INFO - Running setup.py install for mozrunner 10:04:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:48 INFO - Running setup.py install for mozscreenshot 10:04:48 INFO - Running setup.py install for moztest 10:04:48 INFO - Running setup.py install for mozversion 10:04:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:04:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:48 INFO - Cleaning up... 10:04:48 INFO - Return code: 0 10:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:48 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 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:48 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 10:04:48 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 10:04:48 INFO - Using env: {'DISPLAY': ':0', 10:04:48 INFO - 'HOME': '/home/cltbld', 10:04:48 INFO - 'LANG': 'en_US.UTF-8', 10:04:48 INFO - 'LANGUAGE': 'en_US:en', 10:04:48 INFO - 'LOGNAME': 'cltbld', 10:04:48 INFO - 'MAIL': '/var/mail/cltbld', 10:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:48 INFO - 'MOZ_NO_REMOTE': '1', 10:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:48 INFO - 'NO_EM_RESTART': '1', 10:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:48 INFO - 'PWD': '/builds/slave/test', 10:04:48 INFO - 'SHELL': '/bin/bash', 10:04:48 INFO - 'SHLVL': '1', 10:04:48 INFO - 'TERM': 'linux', 10:04:48 INFO - 'TMOUT': '86400', 10:04:48 INFO - 'USER': 'cltbld', 10:04:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:48 INFO - '_': '/tools/buildbot/bin/python'} 10:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:48 INFO - Running setup.py (path:/tmp/pip-3hbxHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:49 INFO - Running setup.py (path:/tmp/pip-wiMiM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:49 INFO - Running setup.py (path:/tmp/pip-38Cieu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:49 INFO - Running setup.py (path:/tmp/pip-Hplj7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:49 INFO - Running setup.py (path:/tmp/pip-w1djEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:49 INFO - Running setup.py (path:/tmp/pip-AARB77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:49 INFO - Running setup.py (path:/tmp/pip-v93gBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:49 INFO - Running setup.py (path:/tmp/pip-DpPns8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:49 INFO - Running setup.py (path:/tmp/pip-OvHFSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:49 INFO - Running setup.py (path:/tmp/pip-M9VSxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:49 INFO - Running setup.py (path:/tmp/pip-rmDwqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:49 INFO - Running setup.py (path:/tmp/pip-YuZdlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:49 INFO - Running setup.py (path:/tmp/pip-0r7Neg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:49 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)) 10:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:49 INFO - Running setup.py (path:/tmp/pip-Acti87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:50 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)) 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:50 INFO - Running setup.py (path:/tmp/pip-s2zSYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:50 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)) 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:50 INFO - Running setup.py (path:/tmp/pip-qTT99x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:50 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)) 10:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:50 INFO - Running setup.py (path:/tmp/pip-IaGbib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:50 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)) 10:04:50 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)) 10:04:50 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)) 10:04:50 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)) 10:04:50 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)) 10:04:50 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)) 10:04:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:52 INFO - Downloading blessings-1.6.tar.gz 10:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:52 INFO - Installing collected packages: blessings 10:04:52 INFO - Running setup.py install for blessings 10:04:52 INFO - Successfully installed blessings 10:04:52 INFO - Cleaning up... 10:04:52 INFO - Return code: 0 10:04:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:04:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:52 INFO - Reading from file tmpfile_stdout 10:04:52 INFO - Current package versions: 10:04:52 INFO - argparse == 1.2.1 10:04:52 INFO - blessings == 1.6 10:04:52 INFO - blobuploader == 1.2.4 10:04:52 INFO - docopt == 0.6.1 10:04:52 INFO - manifestparser == 1.1 10:04:52 INFO - mozInstall == 1.12 10:04:52 INFO - mozcrash == 0.17 10:04:52 INFO - mozdebug == 0.1 10:04:52 INFO - mozdevice == 0.48 10:04:52 INFO - mozfile == 1.2 10:04:52 INFO - mozhttpd == 0.7 10:04:52 INFO - mozinfo == 0.9 10:04:52 INFO - mozleak == 0.1 10:04:52 INFO - mozlog == 3.1 10:04:52 INFO - moznetwork == 0.27 10:04:52 INFO - mozprocess == 0.22 10:04:52 INFO - mozprofile == 0.28 10:04:52 INFO - mozrunner == 6.11 10:04:52 INFO - mozscreenshot == 0.1 10:04:52 INFO - mozsystemmonitor == 0.0 10:04:52 INFO - moztest == 0.7 10:04:52 INFO - mozversion == 1.4 10:04:52 INFO - psutil == 3.1.1 10:04:52 INFO - requests == 1.2.3 10:04:52 INFO - wsgiref == 0.1.2 10:04:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:52 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 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:52 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 10:04:52 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 10:04:52 INFO - Using env: {'DISPLAY': ':0', 10:04:52 INFO - 'HOME': '/home/cltbld', 10:04:52 INFO - 'LANG': 'en_US.UTF-8', 10:04:52 INFO - 'LANGUAGE': 'en_US:en', 10:04:52 INFO - 'LOGNAME': 'cltbld', 10:04:52 INFO - 'MAIL': '/var/mail/cltbld', 10:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:52 INFO - 'MOZ_NO_REMOTE': '1', 10:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:52 INFO - 'NO_EM_RESTART': '1', 10:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:52 INFO - 'PWD': '/builds/slave/test', 10:04:52 INFO - 'SHELL': '/bin/bash', 10:04:52 INFO - 'SHLVL': '1', 10:04:52 INFO - 'TERM': 'linux', 10:04:52 INFO - 'TMOUT': '86400', 10:04:52 INFO - 'USER': 'cltbld', 10:04:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:52 INFO - '_': '/tools/buildbot/bin/python'} 10:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 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)) 10:04:52 INFO - Cleaning up... 10:04:52 INFO - Return code: 0 10:04:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:04:52 INFO - Using env: {'DISPLAY': ':0', 10:04:52 INFO - 'HOME': '/home/cltbld', 10:04:52 INFO - 'LANG': 'en_US.UTF-8', 10:04:52 INFO - 'LANGUAGE': 'en_US:en', 10:04:52 INFO - 'LOGNAME': 'cltbld', 10:04:52 INFO - 'MAIL': '/var/mail/cltbld', 10:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:52 INFO - 'MOZ_NO_REMOTE': '1', 10:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:52 INFO - 'NO_EM_RESTART': '1', 10:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:52 INFO - 'PWD': '/builds/slave/test', 10:04:52 INFO - 'SHELL': '/bin/bash', 10:04:52 INFO - 'SHLVL': '1', 10:04:52 INFO - 'TERM': 'linux', 10:04:52 INFO - 'TMOUT': '86400', 10:04:52 INFO - 'USER': 'cltbld', 10:04:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:52 INFO - '_': '/tools/buildbot/bin/python'} 10:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:52 INFO - Downloading/unpacking jsonschema 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:54 INFO - Downloading/unpacking functools32 (from jsonschema) 10:04:54 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 10:04:54 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 10:04:54 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 10:04:54 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 10:04:54 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 10:04:54 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 10:04:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:55 INFO - warning: no files found matching '*.txt' 10:04:55 INFO - no previously-included directories found matching 'build' 10:04:55 INFO - no previously-included directories found matching 'dist' 10:04:55 INFO - no previously-included directories found matching '.git*' 10:04:55 INFO - Installing collected packages: jsonschema, functools32 10:04:55 INFO - Running setup.py install for functools32 10:04:55 INFO - warning: no files found matching '*.txt' 10:04:55 INFO - no previously-included directories found matching 'build' 10:04:55 INFO - no previously-included directories found matching 'dist' 10:04:55 INFO - no previously-included directories found matching '.git*' 10:04:55 INFO - Successfully installed jsonschema functools32 10:04:55 INFO - Cleaning up... 10:04:55 INFO - Return code: 0 10:04:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc82699ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, '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': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', '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 10:04: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', 'flake8'] in /builds/slave/test/build 10:04: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 flake8 10:04:55 INFO - Using env: {'DISPLAY': ':0', 10:04:55 INFO - 'HOME': '/home/cltbld', 10:04:55 INFO - 'LANG': 'en_US.UTF-8', 10:04:55 INFO - 'LANGUAGE': 'en_US:en', 10:04:55 INFO - 'LOGNAME': 'cltbld', 10:04:55 INFO - 'MAIL': '/var/mail/cltbld', 10:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:55 INFO - 'MOZ_NO_REMOTE': '1', 10:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:55 INFO - 'NO_EM_RESTART': '1', 10:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:55 INFO - 'PWD': '/builds/slave/test', 10:04:55 INFO - 'SHELL': '/bin/bash', 10:04:55 INFO - 'SHLVL': '1', 10:04:55 INFO - 'TERM': 'linux', 10:04:55 INFO - 'TMOUT': '86400', 10:04:55 INFO - 'USER': 'cltbld', 10:04:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:55 INFO - '_': '/tools/buildbot/bin/python'} 10:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:55 INFO - Downloading/unpacking flake8 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:04:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:04:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:58 INFO - no previously-included directories found matching 'docs/_build' 10:04:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:04:58 INFO - Running setup.py install for pep8 10:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:58 INFO - no previously-included directories found matching 'docs/_build' 10:04:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:04:58 INFO - Cleaning up... 10:04:58 INFO - Return code: 0 10:04:58 INFO - Running post-action listener: _resource_record_post_action 10:04:58 INFO - Running post-action listener: _start_resource_monitoring 10:04:58 INFO - Starting resource monitoring. 10:04:58 INFO - ##### 10:04:58 INFO - ##### Running install step. 10:04:58 INFO - ##### 10:04:58 INFO - Running pre-action listener: _resource_record_pre_action 10:04:58 INFO - Running main action method: install 10:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:58 INFO - Reading from file tmpfile_stdout 10:04:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:04:58 INFO - Reading from file tmpfile_stdout 10:04:58 INFO - Output received: 10:04:58 INFO - Usage: mozinstall [options] installer 10:04:58 INFO - Options: 10:04:58 INFO - -h, --help show this help message and exit 10:04:58 INFO - -d DEST, --destination=DEST 10:04:58 INFO - Directory to install application into. [default: 10:04:58 INFO - "/builds/slave/test"] 10:04:58 INFO - --app=APP Application being installed. [default: firefox] 10:04:58 INFO - mkdir: /builds/slave/test/build/application 10:04:58 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'] 10:04:58 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 10:05:14 INFO - Reading from file tmpfile_stdout 10:05:14 INFO - Output received: 10:05:14 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:14 INFO - Running post-action listener: _resource_record_post_action 10:05:14 INFO - ##### 10:05:14 INFO - ##### Running run-tests step. 10:05:14 INFO - ##### 10:05:14 INFO - Running pre-action listener: _resource_record_pre_action 10:05:14 INFO - Running main action method: run_tests 10:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:14 INFO - Python 2.7.3 10:05:14 INFO - Return code: 0 10:05:14 INFO - grabbing minidump binary from tooltool 10:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:14 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 0x2d26410>, '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 0x2d27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d277a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:14 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 10:05:14 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 10:05:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:14 INFO - Return code: 0 10:05:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:05:15 INFO - Return code: 0 10:05:15 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/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 10:05:15 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/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 10:05:15 INFO - Using env: {'DISPLAY': ':0', 10:05:15 INFO - 'HOME': '/home/cltbld', 10:05:15 INFO - 'LANG': 'en_US.UTF-8', 10:05:15 INFO - 'LANGUAGE': 'en_US:en', 10:05:15 INFO - 'LOGNAME': 'cltbld', 10:05:15 INFO - 'MAIL': '/var/mail/cltbld', 10:05:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:15 INFO - 'MOZ_NO_REMOTE': '1', 10:05:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:15 INFO - 'NO_EM_RESTART': '1', 10:05:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:15 INFO - 'PWD': '/builds/slave/test', 10:05:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:15 INFO - 'SHELL': '/bin/bash', 10:05:15 INFO - 'SHLVL': '1', 10:05:15 INFO - 'TERM': 'linux', 10:05:15 INFO - 'TMOUT': '86400', 10:05:15 INFO - 'USER': 'cltbld', 10:05:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576', 10:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:15 INFO - '_': '/tools/buildbot/bin/python'} 10:05:15 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/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 10:05:15 INFO - mozversion application_buildid: 20160530072146 10:05:15 INFO - mozversion application_changeset: b2f0425218851914b703b902ed56c6148b37b537 10:05:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:05:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:15 INFO - mozversion application_name: Firefox 10:05:15 INFO - mozversion application_remotingname: firefox-dev 10:05:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:05:15 INFO - mozversion application_vendor: Mozilla 10:05:15 INFO - mozversion application_version: 48.0a2 10:05:15 INFO - mozversion platform_buildid: 20160530072146 10:05:15 INFO - mozversion platform_changeset: b2f0425218851914b703b902ed56c6148b37b537 10:05:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:05:15 INFO - mozversion platform_version: 48.0a2 10:05:15 INFO - using testdate: 1464627915 10:05:15 INFO - actual date: 1464627915 10:05:15 INFO - starting webserver on 'localhost:60732' 10:05:15 INFO - SUITE-START | Running 2 tests 10:05:15 INFO - TEST-START | dromaeo_css 10:05:15 INFO - operating with platform_type : linux_ 10:05:15 INFO - Initialising browser for dromaeo_css test... 10:05:15 INFO - TEST-INFO | started process 15478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4t3z76/profile http://localhost:60732/getInfo.html) 10:05:19 INFO - PROCESS | 15478 | 10:05:19 INFO - PROCESS | 15478 | (process:15558): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:05:19 INFO - PROCESS | 15478 | __metrics Screen width/height:1600/1200 10:05:19 INFO - PROCESS | 15478 | colorDepth:24 10:05:19 INFO - PROCESS | 15478 | Browser inner width/height: 1024/697 10:05:19 INFO - PROCESS | 15478 | __metrics 10:05:20 ERROR - PROCESS | 15478 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:05:21 INFO - TEST-INFO | 15478: exit 0 10:05:21 INFO - Browser initialized. 10:05:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:21 INFO - TEST-INFO | started process 15609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4t3z76/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:23 INFO - PROCESS | 15609 | 10:05:23 INFO - PROCESS | 15609 | (process:15676): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:05:33 INFO - PROCESS | 15609 | RSS: Main: 152420352 10:05:33 INFO - PROCESS | 15609 | 10:06:22 INFO - PROCESS | 15609 | 1464627982685 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] 10:08:30 INFO - PROCESS | 15609 | Cycle 1(1): loaded http://localhost:60732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60732/tests/dromaeo/cssquery-ext.html) 10:08:31 INFO - PROCESS | 15609 | RSS: Main: 156327936 10:08:31 INFO - PROCESS | 15609 | 10:11:33 INFO - PROCESS | 15609 | Cycle 1(1): loaded http://localhost:60732/tests/dromaeo/cssquery-ext.html (next: http://localhost:60732/tests/dromaeo/cssquery-jquery.html) 10:11:33 INFO - PROCESS | 15609 | RSS: Main: 153518080 10:11:33 INFO - PROCESS | 15609 | 10:14:35 INFO - PROCESS | 15609 | Cycle 1(1): loaded http://localhost:60732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60732/tests/dromaeo/cssquery-mootools.html) 10:14:36 INFO - PROCESS | 15609 | RSS: Main: 153358336 10:14:36 INFO - PROCESS | 15609 | 10:17:37 INFO - PROCESS | 15609 | Cycle 1(1): loaded http://localhost:60732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60732/tests/dromaeo/cssquery-prototype.html) 10:17:38 INFO - PROCESS | 15609 | RSS: Main: 153030656 10:17:38 INFO - PROCESS | 15609 | 10:20:40 INFO - PROCESS | 15609 | Cycle 1(1): loaded http://localhost:60732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60732/tests/dromaeo/cssquery-yui.html) 10:20:41 INFO - PROCESS | 15609 | RSS: Main: 154853376 10:20:41 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | Cycle 1(1): loaded http://localhost:60732/tests/dromaeo/cssquery-yui.html (next: http://localhost:60732/tests/dromaeo/cssquery-dojo.html) 10:23:43 INFO - PROCESS | 15609 | RSS: Main: 156172288 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | __start_tp_report 10:23:43 INFO - PROCESS | 15609 | _x_x_mozilla_page_load 10:23:43 INFO - PROCESS | 15609 | _x_x_mozilla_page_load_details 10:23:43 INFO - PROCESS | 15609 | |i|pagename|runs| 10:23:43 INFO - PROCESS | 15609 | |0;dojo.html;3409.3692666856628;3438.1748380388713;3447.741419393546;3473.9925421627713;3480.947785783212;5686.971565142174;5711.314642242936;5739.827805165846;5777.82666520004;5782.479576838084;5733.111367738007;5799.072148456248;5799.942000579993;5801.216835727176;5802.274715660543;5191.402988656297;5230.450802665722;5268.420473747885;5307.65500242483;5344.931013797237;5072.4673909239555;5183.015227106856;5372.946270537283;5389.272448219499;5390.9191362129595;5173.327467429229;5187.170052791555;5232.869178270555;5295.285136506561;5314.096603577382;5231.450697676765;5248.580113590922;5257.894842103136;5260.447652996419;5262.289590905255;5123.795048198068;5144.228365745131;5257.605679574009;5261.15821468567;5264.499872512105;5456.727163641842;5552.3892371839065;5606.579506536985;5618.0449323614675;5647.971760141214;6015.75936962521;6047.213862197887;6061.757529698807;6069.848253793646;6082.178905847698;6043.697815109227;6107.786227482061;6117.357677443893;6118.4799292060225;6140.078988151813;5478.260434841325;5550.27846379972;5735.627184233012;5789.276340457485;5795.681237531934;6172.444479996821;6193.752249909953;6200.906986395207;6202.751889924352;6260.060990851409;5959.374265702126;5969.074793407029;5979.342272350038;5988.8802223956145;6045.183900173508;6093.329733729286;6108.602940808833;6108.72510737009;6111.877762444727;6124.938750612437;6079.817605471843;6082.787102451393;6085.574009819358;6086.087086936995;6091.817245482643;5881.558883083786;6052.576319657582;6082.7262773174425;6127.464420129056;6135.447809697149;4675.836345727883;4694;4700.341952126705;4700.435947686299;4711.151992641289;4166.604172603597;4175.373693945932;4206.72656277341;4207.368894665825;4244.893877653021;5781.53747700183;5820.417958204146;5841.912371314434;5862.355140934494;5893.499052580579;6050.6672133032225;6250.562460627803;6318.08387783778;6324.2410910691015;6347.650879201688;5628.352739434936;5866.677332746654;5892.499137573269;5915.40845915405;5931.6441013539325;5045.091883460939;5104.897902041938;5110;5140.640155189101;5158.690478571298;6308.432241098323;6326.051092336186;6350.0792385103905;6351.2696039956;6363.618182908947;6063.909041364295;6127.264728232641;6132.141500190066;6143.600665956787;6151.138840562415;6302.5588208826775;6368;6412.326705695835;6414;6430.678466076771;6098.817035488943;6102.572819902564;6117.938820611737;6130.509559235161;6133.26400831903;5938.910916336345;6073.848153796013;6174.6912654368;6205.751769929152;6237.376262373727;5977.252843394575;5989.880202395841;6009.2188015557695;6018.578699491169;6059.212302400836;5965.403459654;5992.041273396236;6031.577789554689;6032.426919442646;6041.24484439445;5779.768809247751;5829.766809327749;5882.911756323744;5961.731722072604;5963.403659634002;5848.64908105515;5890.293164820249;5892.7642894283745;5910.290765108042;5938.138969849434;5785.537157027344;5789.913151302818;5791.9131213031;5804.593678442468;5807.738651760596 10:23:43 INFO - PROCESS | 15609 | |1;ext.html;654.5221987948797;670.7250027488731;673.1014096181598;718.1848601836916;736.0027163193872;40616;41335.79332103335;41339.58660413395;41722.58277417229;41731.58268417315;44727;45043.77478112613;45177.77411112948;45214.417495387665;45384.773076134574;8814.382993190478;8944.150305720947;8972;8982.775430614221;8995.955020224923;8817.16236957488;8963.10368963105;8978.147076027766;9218.262538996898;9220.400673956205;9159.175674189322;9178.54107294636;9208.171264586186;9212.585433655502;9215.2627789777;9135.36052476327;9157.496337701425;9217.216536594398;9226.81546369069;9233.53832308382;9065.546722663841;9125.133112354315;9151.725448236564;9197.67808126719;9204.401713888576;45141.322880156826;45568;45746;45795.77102114502;45809.08381832378;3709.9443508347395;3876.2441323941844;3962.1085255817497;4158.251514727348;4399.780010999437;34123;34191.48712769311;34542.309153817034;34711.82644086763;34724.652753472394;4321.65426765858;4372.89067773305;4391.73649581023;4406.206882761102;4439.800208990603;334338;334406;335824.99999999756;336750;337627;66338.66830665816;66536;66663;66692.66653666798;66818;72402.27597724061;73976;74024.62987685027;74226.62886685532;74322.6283868588;18911.24355025811;19042.809571904105;19061.332853350345;19110.904445477685;19169.52076198106;14396.784048239284;14439.639009024859;14511.564653060213;14525;14535.709285814224;20714.58570828575;20952.89523552403;20974.370768876957;21048.684269735968;21085.89457052705;7291.34377905991;7475.318757744045;7477.850442991218;7535.8116047098165;7748.457607967388;1062.081299675775;1065.9467026648636;1113.7494063835572;1174.4949671641277;1221.712897469094;33850.66149338525;33997.490037649455;34073;34126;34159.01988988632;1178.793711100571;1191.713988642737;1198.2930071258;1253.4547471849774;1258.3708145927037;15855.603609909844;15936.521904342888;16015.839841601668;16123.677526449404;16187.514374568782;379786;575408;576700;582893;591701;65348.67325663341;66386.33613663899;66399;66718.33281667218;66808;1518.7418138916412;1519.0885468718902;1519.7036577867432;1527.8013858198362;1632.4041724770373;32913.50629740508;33453;34312;34414.48378274378;34503.309933801684;56193;56738;56869.43130568641;57033.42966570281;57279.71360143173;482266;484089;487568;488170;488222;31625.683743162273;32206.19484512906;32230.83884580562;32477.35045299128;32590.51114233241;51387.515852331526;52329.47670523398;52562;52776.73611632071;53533.46466535285;43294;43600;44084;44101.77949110234;45190.77404612956;42872;44270.98939294056;44545;44708.55291447174;45281.32078018766;45347.31979020251;45658;45809.77095114503;46059;46101;36261.456078159375;36797.44803827998;37006.814965926074;37444.43833342448;37595;27510.17469475919;29647.851760741058;29760;29764.255893602833;30037 10:23:43 INFO - PROCESS | 15609 | |2;jquery.html;428.6903509777628;434.91736570051665;436.39341315571363;441.6091758793469;447.9260921947879;18784.060796960166;18842.717359239607;19104.42686719397;19189.136488858;19386;19686.507837304038;19796;20646.174153033862;20986.37040888772;21117.366479005617;5778.971105144468;5846.941530584693;6001.189839371673;6018.458338749533;6027.306859711123;5929.911051334212;5965.642061476304;5965.791197308095;5966.492848107916;5989.700514974255;5715.371309155989;5820.505257053155;5869.090291004901;5910.024845900442;5937.940620593804;5854.18041474194;5885.234919460486;5907.940920590782;5916.230889984275;5929.377415371388;5357.491038351351;5480.479354461319;5733.827985160452;5756.338021127582;5757.165211044375;14332.64168395788;14586.41654333836;14766.409343626243;14799.40802367904;14938;2430.9149179778624;2447.8164137689746;2496.6504689343506;2652.7877769778565;3182.204448887778;10579.788404231873;10584;10624.09695175911;10722.892771072267;10788.73028174294;1951.990240048805;1978.1395093134533;2019.9496261943707;2020.5554777948828;2104.726385569866;79644;81116.59441702813;81975;83222.58388708078;84074;11465.598704045486;11686.824697629543;11714.589989350503;11912.166148369704;11927.210918362314;16559.83440165583;16609.501714948572;16710.164491775362;16725.163741813103;16793.244304006348;8657.95671021641;8783.824323513494;8817.955910220537;8833;8920.375573709907;8375.8324833503;8437.704680336159;8447;8560;8642.265407440313;4773.331733557305;5106.391486681683;5146.150885103991;5185.2999845021195;5200.791968321225;2128.6062078515524;2141.1114387529315;2142.7964343387353;2194.2758889566403;2218.8003079722903;983.6852207293597;1035.3787727363522;1065.9307145035548;1095.6895612288329;1152.3546813784308;18656.813431865507;19091.331803387093;19460.31888883882;19491.902540487208;19644.508887277647;1080.1844607321423;1107.9778404431866;1113.1373185780922;1113.7883802077579;1121.0359091181576;10632.946835265775;10929.672109836718;10986.670399888017;10988.340699558052;11017.173711971634;543823;572175;573485;596917;600945;75805;92921.5353923226;101210;101586;101945.49027254817;1020.7652239984845;1032.4579595712312;1040.1107053469175;1068.887766784492;1077.375122429005;17416.564585885455;17658.381956631456;17677.204525796114;17769.73345399846;18134;37901.62098379091;38348;38407.80796096002;41119.38320925248;41985.58014419817;57143.14285285641;59338.40661593329;60079;60190.39809602023;60202.096968546386;9041.728748137566;9176.265898727952;9212.815743685223;9298.95350523243;9445.527723613654;12094.637160884835;13208.27354495512;13345.599632011055;13477.730445391233;13532.729345413234;11712.238704484182;11834.585789497327;11859.34773587461;11975.820362694742;12104.818427723416;11529.711757206136;11537.826932596186;11701.590444334748;11862.288262704265;11923.582674606347;11804.468798904241;11849.881501185222;11996.460159292677;11996.64010079699;12162.148649594443;9011.729648110568;9023.4134781239;9189.632414703337;9319.34764566501;9337.766555836159;10334.844977325196;11725.120615953667;11813.82279265829;11835.112366572714;12062.276263424223 10:23:43 INFO - PROCESS | 15609 | |3;mootools.html;1537.277479584595;1552.6739384729206;1747.868909831763;1839.779226492821;1908.1031914999944;7718;8440.746777596667;8575.056743758189;8762.605682744284;8775.429597076185;8519.914800852006;8534.786630334245;8599;8612.655493780258;8637.222649961503;2418.2866054513875;2427.0170580914714;2429.8822541630784;2431.3678443604704;2440.04838113136;2364.137089962169;2386.093284551868;2423.660687503751;2428.5992811186134;2434.500927309897;2374.6675465434855;2390.40239940015;2414.903403863852;2449.081594402099;2449.9265022049276;2389.8207634427486;2396.880155992202;2397.7961873240797;2399.956019131683;2432.1365915100237;2348.5537747827857;2386.4033991502124;2388.522295540899;2393.3298676370646;2404.1224952892244;8794.86807697885;8816.206541411304;8833.779155521099;8840.911590884074;8877.201051905295;5348.598855085846;5466.508014278695;5485.780568777244;5496.6701997880255;5501.5323697485765;3370.3764803511185;3385.9830700846583;3402.4556071028765;3538.8938331850086;3551.271989242199;1099.9725006874812;1105.4030823355379;1107;1123.8314252862053;1150.442035612727;12426.689332766753;12443.813342799865;12469.812952805714;12482.625521234288;12518.812217816649;4687.5781179693995;4760.262159365304;4783.162946484351;4798.520147985243;4829.444613869379;10436.37381757097;10547.103496202908;10583.523741431654;10623.628173013907;10651.467426628638;5511.145772405283;5563.304586926634;5572.4706152915405;5583.330000399978;5592.440755924375;4275.5296917339065;4819.963707802769;4825.034993001414;4908.582770464551;5076.466970968069;4109.958900411018;4155.937660935088;4230.386593943861;4392.626626736699;4398.3842262083335;1321.5859030836912;1326.1247576599399;1330.720548684787;1332.1807088640417;1336.5188532128425;1040.7346126737634;1050.5902697947806;1054.1092776603757;1070.9518071686794;1083.539495714334;6164.599301045418;6165.106059621419;6297.685115744286;6318.684065796691;6413.35866413355;453.3019150508246;454.07368967306326;454.4773510462994;1080.7946490166844;1120.7254222715324;4107.979460102681;4166.687498437569;4183.790810459464;4193.18232944579;4195.244855925963;10728.302660327054;10973.286736362112;11173.273737207219;11188.049015833745;11189.552417903356;11080.501377437873;11086.33481991067;11111.666650000512;11119.72200694989;11127.666170014912;8430.241278284984;8483.06686264498;8576.1423857615;8588.969323681198;8594.656213751505;6090.147379366981;6113.23584551931;6128.540359472968;6245.344238854855;6289.591176573508;9370.906290937004;9846.704598862045;9887.406755594688;9918.107370336416;9989.60041598328;10002.29983901149;10011.749706257111;10072.143867771028;10118;10174.8473772892;6934.549254298455;7504.812379690551;7678.731244406419;7741.651625676745;7832.84334313322;8296.460730052528;8303.543305118277;8354.5405002723;8402.747917562483;8412.873806893023;7438.814029649302;7610.124835643972;7656.119546252029;7727.806804829699;7837.098733645704;7224.566526008456;7407.333339999426;7418.851622967619;7443.032405787213;7471.88792168107;7135.143782746104;7179.246179151322;7198.748043818441;7232;7281.126264848041;5090.592752579711;5150.639455238097;5156.690598564098;5265.447128051653;5287.735613219401;5213.191955246943;5234.947650523598;5342.065138600807;5386.299781028598;5434.076207044891 10:23:43 INFO - PROCESS | 15609 | |4;prototype.html;349.9982500087499;350.87543921907724;357.2016543026336;363.8508211633229;368.2653107051433;6617.106690596768;6789.117414736077;6796.320367963207;6819.659017049153;6843.144606924135;6619.238787539434;6652.234992975809;6656.134702488682;6663.167104111986;6676.532642715012;4845.660803743739;5068.72122033288;5077.695338279696;5078.619103567229;5084.415292241393;5005.57452616528;5018.422881368635;5023.296738456619;5047.520485553867;5051.974740126294;4965.957148998715;4966.180580204262;4974.1295273327205;4988.376452943382;4992.375953005874;4979.427365852919;4985.700857948535;4988.950110498885;5008.524190201925;5015.548600625924;4262.957370426287;4321.956780432219;4322.286822674255;4331.610155086026;4336.046069864625;6419.293877673452;6428.260750013715;6432.388923052349;6437.517186211053;6443.9355606443805;5577.274954255961;5696.544276457874;5699.2306038684665;5710.2862142232225;5847.356790753014;6930.72277108915;6954.7133780250815;6958.686859091353;6965.860682786316;6980.511364204508;4716.339712440261;4729.43246810385;4765.213739732974;4772.141014617368;4774.188387974018;7318.231585683479;7336.559806411632;7347.448941329421;7391.186969433358;7396.815079622998;4803.327534145223;4903.705777653281;4925.655204135676;4928.310036594879;4945.505449455098;4960.255961605716;4960.330355402047;4991.675541089818;4993.350864387607;4995.825146119941;5717.085266357363;5807.070868661079;5816.069428891357;5821.243238378984;5827.854303642443;7045.225025247219;7065.646717664096;7095.3968912643;7103;7104.183018952784;1735.7569940208382;1754.8683848711398;1756.3852651572104;1763.1272520102375;1765.13508380895;1113.1373185781085;1136.9260998035268;1144.9026832719146;1148.3224897310627;1159.4724400397968;6808.489363297773;6821.488388370892;6823.658817059227;6823.897641535381;6845.383915447634;7293.197748247689;7295.088113985752;7303.561786292839;7318.926810731931;7356.889646655304;6676.6327851967635;6789.966050169717;6805.319468053155;6890.689918953659;6936.306369363124;3965.7422267552515;3993.4409182714444;4002.3596224603925;4012.6789856811383;4016.7991600419864;7700.961495192488;7724.7682569523;7732.226777322223;7747.30274275318;7764.8058798529355;7565.848683026308;7569.583672898044;7592.696292148363;7621.618919054025;7636.121845987672;7416.888746668804;7613.961930190314;7616.0860696716745;7617.314441700273;7677.385809135256;7272.345488906024;7316.780496585111;7318.3047610476915;7320.084989376328;7332.266773322838;7231.963840180765;7258.419326453976;7274.418046556369;7290.890636640349;7325.267473252632;7666.540007599562;7707.730229441942;7715.267049630276;7715.884261736191;7721.92278077212;4779.115863565252;4951.430585482715;4954.950450495449;4959.380077490314;4963.503649635008;7300.744473943387;7333.413326933939;7334.853302934018;7342.853142937218;7391.6304184791625;7074.575525468488;7082.18554866197;7087.397571206505;7088.64556772149;7113.644317784194;6948.374646281859;6988.580685158907;7018;7018.824529386806;7022.262662420372;6930.653467326512;6939.236683964861;6947.617881016593;6951.860962780817;6957.582545047313;7118.074650295428;7128.358447739728;7138.785836424916;7140.892886606601;7158.141023077264;6933.722651094102;6935.202451718117;6940;6951.096357473496;6952.165740111219 10:23:43 INFO - PROCESS | 15609 | |5;yui.html;821.5892053973012;831.9584020798959;861.2378045429795;877.1141147441083;915.7573243090582;13966.581002569927;14229.573112806607;15822.604434889105;15838.920805395986;15844.920775396136;13539;13587.796183057237;13605.183688978668;13752.587422377319;13827.516036938709;874.6020560644923;907.7912080221553;908.6592527802075;908.9181973622373;909.7998440343147;908.0601577367426;908.8636704494313;913.6071489259616;916.665417122752;919.1130559010553;948.2224575847807;954.3367359685021;954.7422196007074;956.4022485946283;958.420155805738;948.2319321349694;949.8100379924008;950.4724877692878;952.1383148250844;958.5446912716474;703.1527009952995;706.0362605044129;706.1631966120112;706.6572712234562;708.6952610377588;13844.169349839041;13850.238236896967;13885.652858678513;13922;13946.58160255194;14436.133831970115;14713.337899794535;14775.70448591033;14823.407063717439;14851.183184924825;11767.23512971654;11916.940415297868;12194.81707774384;12336.383180840921;12529.624111276586;3998.7200895937294;4056.4320995060716;4063.045184381668;4094.160697057126;4098.610631989986;59136.11295830566;59359.99999999957;59378.40621593772;59450;59479;10545.736356590993;10748.301360411548;10758.274734626275;10862.891371086345;10916.399598022026;18932.526686832665;18990.71513927292;19020.42938711841;19022.144003519876;19045.523861903563;8508.10664880191;8588.828223435621;8605.354598405145;8640.481571105754;8643.438176518506;5025.6482046256415;5030.647854650212;5051.797928082909;5075.898482030412;5119.0529751995255;3498.5626796650417;3526.858925642997;3532.7350448716447;3535.911602209965;3573.1245844767677;599.7031469422664;610.6854969690613;623.5136593457111;625.7497001199465;626.9404406581367;752.9360004399578;812.2689579378607;832.3216578488513;854.3933806996978;866.8006358537572;8914.910850891538;8961.462312261285;9679.70960871175;9680.322377433513;9757.121859032579;751.9210482899326;764.8699721047435;776.4293244465314;803.269025187077;823.9823817585277;4469.351943968107;4538.591526762541;4672.836450724276;4714.316424118484;4746.976265118652;66822.33177668258;69323.65338173277;69834;69940.30059699439;70209;51026.23460648093;59354.70322648445;60009.399906000384;60363.09455358173;60443.09335359973;54918.72540637351;55393.723031385394;56115;56592;56633.433665662815;9684.806303874024;9829.115379615869;9845;10086;10340.689779306633;38981.6101838978;40207.396889046104;40656.39015414712;40938.1812363757;41760.79119604383;47741.52258477371;52672.473275266755;52803;53059;53969.730151348995;12767.80848287295;12806.487740490276;13070.54253101137;13327.866721332663;13504.257265850472;13831.100978436369;14507.782383264048;14837.258137093319;15039.398424062914;15481.148536830582;13165.602103137668;13646.658833528843;13774.724505510034;14009.229492378017;14633.122012679274;12640.178388404724;12713.50274040857;12948.09363344557;13939.372728227052;14096.026556281924;13656.726865462833;13882.236476993863;13992.720145597235;14076.296185190495;14360.784588230976;10715.785684286426;10857.945710271399;11245.269057511236;11685.357305348287;11822.408879555816;10770.461476926279;10812.405317707602;10844.457777110954;10926.399048052433;11364.943175284401 10:23:43 INFO - PROCESS | 15609 | __end_tp_report 10:23:43 INFO - PROCESS | 15609 | __start_cc_report 10:23:43 INFO - PROCESS | 15609 | _x_x_mozilla_cycle_collect,337 10:23:43 INFO - PROCESS | 15609 | __end_cc_report 10:23:43 INFO - PROCESS | 15609 | __startTimestamp1464629023783__endTimestamp 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | ------- Summary: start ------- 10:23:43 INFO - PROCESS | 15609 | Number of tests: 6 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | [#0] dojo.html Cycles:165 Average:5688.67 Median:5892.50 stddev:627.83 (10.7%) stddev-sans-first:603.75 10:23:43 INFO - PROCESS | 15609 | Values: 3409.4 3438.2 3447.7 3474.0 3480.9 5687.0 5711.3 5739.8 5777.8 5782.5 5733.1 5799.1 5799.9 5801.2 5802.3 5191.4 5230.5 5268.4 5307.7 5344.9 5072.5 5183.0 5372.9 5389.3 5390.9 5173.3 5187.2 5232.9 5295.3 5314.1 5231.5 5248.6 5257.9 5260.4 5262.3 5123.8 5144.2 5257.6 5261.2 5264.5 5456.7 5552.4 5606.6 5618.0 5648.0 6015.8 6047.2 6061.8 6069.8 6082.2 6043.7 6107.8 6117.4 6118.5 6140.1 5478.3 5550.3 5735.6 5789.3 5795.7 6172.4 6193.8 6200.9 6202.8 6260.1 5959.4 5969.1 5979.3 5988.9 6045.2 6093.3 6108.6 6108.7 6111.9 6124.9 6079.8 6082.8 6085.6 6086.1 6091.8 5881.6 6052.6 6082.7 6127.5 6135.4 4675.8 4694.0 4700.3 4700.4 4711.2 4166.6 4175.4 4206.7 4207.4 4244.9 5781.5 5820.4 5841.9 5862.4 5893.5 6050.7 6250.6 6318.1 6324.2 6347.7 5628.4 5866.7 5892.5 5915.4 5931.6 5045.1 5104.9 5110.0 5140.6 5158.7 6308.4 6326.1 6350.1 6351.3 6363.6 6063.9 6127.3 6132.1 6143.6 6151.1 6302.6 6368.0 6412.3 6414.0 6430.7 6098.8 6102.6 6117.9 6130.5 6133.3 5938.9 6073.8 6174.7 6205.8 6237.4 5977.3 5989.9 6009.2 6018.6 6059.2 5965.4 5992.0 6031.6 6032.4 6041.2 5779.8 5829.8 5882.9 5961.7 5963.4 5848.6 5890.3 5892.8 5910.3 5938.1 5785.5 5789.9 5791.9 5804.6 5807.7 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | [#1] ext.html Cycles:180 Average:63417.18 Median:24355.39 stddev:123320.45 (506.3%) stddev-sans-first:123576.37 10:23:43 INFO - PROCESS | 15609 | Values: 654.5 670.7 673.1 718.2 736.0 40616.0 41335.8 41339.6 41722.6 41731.6 44727.0 45043.8 45177.8 45214.4 45384.8 8814.4 8944.2 8972.0 8982.8 8996.0 8817.2 8963.1 8978.1 9218.3 9220.4 9159.2 9178.5 9208.2 9212.6 9215.3 9135.4 9157.5 9217.2 9226.8 9233.5 9065.5 9125.1 9151.7 9197.7 9204.4 45141.3 45568.0 45746.0 45795.8 45809.1 3709.9 3876.2 3962.1 4158.3 4399.8 34123.0 34191.5 34542.3 34711.8 34724.7 4321.7 4372.9 4391.7 4406.2 4439.8 334338.0 334406.0 335825.0 336750.0 337627.0 66338.7 66536.0 66663.0 66692.7 66818.0 72402.3 73976.0 74024.6 74226.6 74322.6 18911.2 19042.8 19061.3 19110.9 19169.5 14396.8 14439.6 14511.6 14525.0 14535.7 20714.6 20952.9 20974.4 21048.7 21085.9 7291.3 7475.3 7477.9 7535.8 7748.5 1062.1 1065.9 1113.7 1174.5 1221.7 33850.7 33997.5 34073.0 34126.0 34159.0 1178.8 1191.7 1198.3 1253.5 1258.4 15855.6 15936.5 16015.8 16123.7 16187.5 379786.0 575408.0 576700.0 582893.0 591701.0 65348.7 66386.3 66399.0 66718.3 66808.0 1518.7 1519.1 1519.7 1527.8 1632.4 32913.5 33453.0 34312.0 34414.5 34503.3 56193.0 56738.0 56869.4 57033.4 57279.7 482266.0 484089.0 487568.0 488170.0 488222.0 31625.7 32206.2 32230.8 32477.4 32590.5 51387.5 52329.5 52562.0 52776.7 53533.5 43294.0 43600.0 44084.0 44101.8 45190.8 42872.0 44271.0 44545.0 44708.6 45281.3 45347.3 45658.0 45809.8 46059.0 46101.0 36261.5 36797.4 37006.8 37444.4 37595.0 27510.2 29647.9 29760.0 29764.3 30037.0 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | [#2] jquery.html Cycles:180 Average:31530.22 Median:11611.05 stddev:94925.59 (817.5%) stddev-sans-first:95163.15 10:23:43 INFO - PROCESS | 15609 | Values: 428.7 434.9 436.4 441.6 447.9 18784.1 18842.7 19104.4 19189.1 19386.0 19686.5 19796.0 20646.2 20986.4 21117.4 5779.0 5846.9 6001.2 6018.5 6027.3 5929.9 5965.6 5965.8 5966.5 5989.7 5715.4 5820.5 5869.1 5910.0 5937.9 5854.2 5885.2 5907.9 5916.2 5929.4 5357.5 5480.5 5733.8 5756.3 5757.2 14332.6 14586.4 14766.4 14799.4 14938.0 2430.9 2447.8 2496.7 2652.8 3182.2 10579.8 10584.0 10624.1 10722.9 10788.7 1952.0 1978.1 2019.9 2020.6 2104.7 79644.0 81116.6 81975.0 83222.6 84074.0 11465.6 11686.8 11714.6 11912.2 11927.2 16559.8 16609.5 16710.2 16725.2 16793.2 8658.0 8783.8 8818.0 8833.0 8920.4 8375.8 8437.7 8447.0 8560.0 8642.3 4773.3 5106.4 5146.2 5185.3 5200.8 2128.6 2141.1 2142.8 2194.3 2218.8 983.7 1035.4 1065.9 1095.7 1152.4 18656.8 19091.3 19460.3 19491.9 19644.5 1080.2 1108.0 1113.1 1113.8 1121.0 10632.9 10929.7 10986.7 10988.3 11017.2 543823.0 572175.0 573485.0 596917.0 600945.0 75805.0 92921.5 101210.0 101586.0 101945.5 1020.8 1032.5 1040.1 1068.9 1077.4 17416.6 17658.4 17677.2 17769.7 18134.0 37901.6 38348.0 38407.8 41119.4 41985.6 57143.1 59338.4 60079.0 60190.4 60202.1 9041.7 9176.3 9212.8 9299.0 9445.5 12094.6 13208.3 13345.6 13477.7 13532.7 11712.2 11834.6 11859.3 11975.8 12104.8 11529.7 11537.8 11701.6 11862.3 11923.6 11804.5 11849.9 11996.5 11996.6 12162.1 9011.7 9023.4 9189.6 9319.3 9337.8 10334.8 11725.1 11813.8 11835.1 12062.3 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | [#3] mootools.html Cycles:180 Average:5861.28 Median:2571.03 stddev:3279.03 (127.5%) stddev-sans-first:3272.13 10:23:43 INFO - PROCESS | 15609 | Values: 1537.3 1552.7 1747.9 1839.8 1908.1 7718.0 8440.7 8575.1 8762.6 8775.4 8519.9 8534.8 8599.0 8612.7 8637.2 2418.3 2427.0 2429.9 2431.4 2440.0 2364.1 2386.1 2423.7 2428.6 2434.5 2374.7 2390.4 2414.9 2449.1 2449.9 2389.8 2396.9 2397.8 2400.0 2432.1 2348.6 2386.4 2388.5 2393.3 2404.1 8794.9 8816.2 8833.8 8840.9 8877.2 5348.6 5466.5 5485.8 5496.7 5501.5 3370.4 3386.0 3402.5 3538.9 3551.3 1100.0 1105.4 1107.0 1123.8 1150.4 12426.7 12443.8 12469.8 12482.6 12518.8 4687.6 4760.3 4783.2 4798.5 4829.4 10436.4 10547.1 10583.5 10623.6 10651.5 5511.1 5563.3 5572.5 5583.3 5592.4 4275.5 4820.0 4825.0 4908.6 5076.5 4110.0 4155.9 4230.4 4392.6 4398.4 1321.6 1326.1 1330.7 1332.2 1336.5 1040.7 1050.6 1054.1 1071.0 1083.5 6164.6 6165.1 6297.7 6318.7 6413.4 453.3 454.1 454.5 1080.8 1120.7 4108.0 4166.7 4183.8 4193.2 4195.2 10728.3 10973.3 11173.3 11188.0 11189.6 11080.5 11086.3 11111.7 11119.7 11127.7 8430.2 8483.1 8576.1 8589.0 8594.7 6090.1 6113.2 6128.5 6245.3 6289.6 9370.9 9846.7 9887.4 9918.1 9989.6 10002.3 10011.7 10072.1 10118.0 10174.8 6934.5 7504.8 7678.7 7741.7 7832.8 8296.5 8303.5 8354.5 8402.7 8412.9 7438.8 7610.1 7656.1 7727.8 7837.1 7224.6 7407.3 7418.9 7443.0 7471.9 7135.1 7179.2 7198.7 7232.0 7281.1 5090.6 5150.6 5156.7 5265.4 5287.7 5213.2 5234.9 5342.1 5386.3 5434.1 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | [#4] prototype.html Cycles:180 Average:5903.93 Median:6806.90 stddev:1820.81 (26.7%) stddev-sans-first:1777.55 10:23:43 INFO - PROCESS | 15609 | Values: 350.0 350.9 357.2 363.9 368.3 6617.1 6789.1 6796.3 6819.7 6843.1 6619.2 6652.2 6656.1 6663.2 6676.5 4845.7 5068.7 5077.7 5078.6 5084.4 5005.6 5018.4 5023.3 5047.5 5052.0 4966.0 4966.2 4974.1 4988.4 4992.4 4979.4 4985.7 4989.0 5008.5 5015.5 4263.0 4322.0 4322.3 4331.6 4336.0 6419.3 6428.3 6432.4 6437.5 6443.9 5577.3 5696.5 5699.2 5710.3 5847.4 6930.7 6954.7 6958.7 6965.9 6980.5 4716.3 4729.4 4765.2 4772.1 4774.2 7318.2 7336.6 7347.4 7391.2 7396.8 4803.3 4903.7 4925.7 4928.3 4945.5 4960.3 4960.3 4991.7 4993.4 4995.8 5717.1 5807.1 5816.1 5821.2 5827.9 7045.2 7065.6 7095.4 7103.0 7104.2 1735.8 1754.9 1756.4 1763.1 1765.1 1113.1 1136.9 1144.9 1148.3 1159.5 6808.5 6821.5 6823.7 6823.9 6845.4 7293.2 7295.1 7303.6 7318.9 7356.9 6676.6 6790.0 6805.3 6890.7 6936.3 3965.7 3993.4 4002.4 4012.7 4016.8 7701.0 7724.8 7732.2 7747.3 7764.8 7565.8 7569.6 7592.7 7621.6 7636.1 7416.9 7614.0 7616.1 7617.3 7677.4 7272.3 7316.8 7318.3 7320.1 7332.3 7232.0 7258.4 7274.4 7290.9 7325.3 7666.5 7707.7 7715.3 7715.9 7721.9 4779.1 4951.4 4955.0 4959.4 4963.5 7300.7 7333.4 7334.9 7342.9 7391.6 7074.6 7082.2 7087.4 7088.6 7113.6 6948.4 6988.6 7018.0 7018.8 7022.3 6930.7 6939.2 6947.6 6951.9 6957.6 7118.1 7128.4 7138.8 7140.9 7158.1 6933.7 6935.2 6940.0 6951.1 6952.2 10:23:43 INFO - PROCESS | 15609 | 10:23:43 INFO - PROCESS | 15609 | [#5] yui.html Cycles:180 Average:16070.77 Median:4730.65 stddev:18985.74 (401.3%) stddev-sans-first:19004.46 10:23:43 INFO - PROCESS | 15609 | Values: 821.6 832.0 861.2 877.1 915.8 13966.6 14229.6 15822.6 15838.9 15844.9 13539.0 13587.8 13605.2 13752.6 13827.5 874.6 907.8 908.7 908.9 909.8 908.1 908.9 913.6 916.7 919.1 948.2 954.3 954.7 956.4 958.4 948.2 949.8 950.5 952.1 958.5 703.2 706.0 706.2 706.7 708.7 13844.2 13850.2 13885.7 13922.0 13946.6 14436.1 14713.3 14775.7 14823.4 14851.2 11767.2 11916.9 12194.8 12336.4 12529.6 3998.7 4056.4 4063.0 4094.2 4098.6 59136.1 59360.0 59378.4 59450.0 59479.0 10545.7 10748.3 10758.3 10862.9 10916.4 18932.5 18990.7 19020.4 19022.1 19045.5 8508.1 8588.8 8605.4 8640.5 8643.4 5025.6 5030.6 5051.8 5075.9 5119.1 3498.6 3526.9 3532.7 3535.9 3573.1 599.7 610.7 623.5 625.7 626.9 752.9 812.3 832.3 854.4 866.8 8914.9 8961.5 9679.7 9680.3 9757.1 751.9 764.9 776.4 803.3 824.0 4469.4 4538.6 4672.8 4714.3 4747.0 66822.3 69323.7 69834.0 69940.3 70209.0 51026.2 59354.7 60009.4 60363.1 60443.1 54918.7 55393.7 56115.0 56592.0 56633.4 9684.8 9829.1 9845.0 10086.0 10340.7 38981.6 40207.4 40656.4 40938.2 41760.8 47741.5 52672.5 52803.0 53059.0 53969.7 12767.8 12806.5 13070.5 13327.9 13504.3 13831.1 14507.8 14837.3 15039.4 15481.1 13165.6 13646.7 13774.7 14009.2 14633.1 12640.2 12713.5 12948.1 13939.4 14096.0 13656.7 13882.2 13992.7 14076.3 14360.8 10715.8 10857.9 11245.3 11685.4 11822.4 10770.5 10812.4 10844.5 10926.4 11364.9 10:23:43 INFO - PROCESS | 15609 | -------- Summary: end -------- 10:23:43 INFO - PROCESS | 15609 | 10:23:44 INFO - TEST-INFO | 15609: exit 0 10:23:44 INFO - TEST-OK | dromaeo_css | took 1108942ms 10:23:44 INFO - TEST-START | kraken 10:23:44 INFO - operating with platform_type : linux_ 10:23:44 INFO - Initialising browser for kraken test... 10:23:44 INFO - TEST-INFO | started process 15849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplYnuDr/profile http://localhost:60732/getInfo.html) 10:23:47 INFO - PROCESS | 15849 | 10:23:47 INFO - PROCESS | 15849 | (process:15927): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:23:48 INFO - PROCESS | 15849 | __metrics Screen width/height:1600/1200 10:23:48 INFO - PROCESS | 15849 | colorDepth:24 10:23:48 INFO - PROCESS | 15849 | Browser inner width/height: 1024/697 10:23:48 INFO - PROCESS | 15849 | __metrics 10:23:49 ERROR - PROCESS | 15849 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:23:50 INFO - TEST-INFO | 15849: exit 0 10:23:50 INFO - Browser initialized. 10:23:50 INFO - Running cycle 1/1 for kraken test... 10:23:50 INFO - TEST-INFO | started process 15978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplYnuDr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:51 INFO - PROCESS | 15978 | 10:23:51 INFO - PROCESS | 15978 | (process:16046): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:24:01 INFO - PROCESS | 15978 | RSS: Main: 152231936 10:24:01 INFO - PROCESS | 15978 | 10:24:04 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60732/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:05 INFO - PROCESS | 15978 | RSS: Main: 157147136 10:24:05 INFO - PROCESS | 15978 | 10:24:07 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60732/tests/kraken/driver.html?testName=audio-dft) 10:24:08 INFO - PROCESS | 15978 | RSS: Main: 157048832 10:24:08 INFO - PROCESS | 15978 | 10:24:11 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60732/tests/kraken/driver.html?testName=audio-fft) 10:24:12 INFO - PROCESS | 15978 | RSS: Main: 157278208 10:24:12 INFO - PROCESS | 15978 | 10:24:14 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60732/tests/kraken/driver.html?testName=audio-oscillator) 10:24:14 INFO - PROCESS | 15978 | RSS: Main: 157630464 10:24:14 INFO - PROCESS | 15978 | 10:24:16 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:17 INFO - PROCESS | 15978 | RSS: Main: 157261824 10:24:17 INFO - PROCESS | 15978 | 10:24:20 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60732/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:21 INFO - PROCESS | 15978 | RSS: Main: 157540352 10:24:21 INFO - PROCESS | 15978 | 10:24:24 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60732/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:25 INFO - PROCESS | 15978 | RSS: Main: 157577216 10:24:25 INFO - PROCESS | 15978 | 10:24:28 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60732/tests/kraken/driver.html?testName=json-parse-financial) 10:24:28 INFO - PROCESS | 15978 | RSS: Main: 157458432 10:24:28 INFO - PROCESS | 15978 | 10:24:30 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:30 INFO - PROCESS | 15978 | RSS: Main: 157380608 10:24:30 INFO - PROCESS | 15978 | 10:24:32 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:33 INFO - PROCESS | 15978 | RSS: Main: 157495296 10:24:33 INFO - PROCESS | 15978 | 10:24:35 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:35 INFO - PROCESS | 15978 | RSS: Main: 157245440 10:24:35 INFO - PROCESS | 15978 | 10:24:38 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:38 INFO - PROCESS | 15978 | RSS: Main: 158470144 10:24:38 INFO - PROCESS | 15978 | 10:24:41 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:42 INFO - PROCESS | 15978 | RSS: Main: 157962240 10:24:42 INFO - PROCESS | 15978 | 10:24:43 INFO - PROCESS | 15978 | Cycle 1(1): loaded http://localhost:60732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60732/tests/kraken/driver.html?testName=ai-astar) 10:24:44 INFO - PROCESS | 15978 | RSS: Main: 159596544 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | __start_tp_report 10:24:44 INFO - PROCESS | 15978 | _x_x_mozilla_page_load 10:24:44 INFO - PROCESS | 15978 | _x_x_mozilla_page_load_details 10:24:44 INFO - PROCESS | 15978 | |i|pagename|runs| 10:24:44 INFO - PROCESS | 15978 | |0;ai-astar;109;111;103;113;110;112;101;109;110;110 10:24:44 INFO - PROCESS | 15978 | |1;audio-beat-detection;158;129;157;177;131;157;153;128;172;125 10:24:44 INFO - PROCESS | 15978 | |2;audio-dft;163;162;162;162;163;162;163;162;163;163 10:24:44 INFO - PROCESS | 15978 | |3;audio-fft;72;77;78;190;83;77;75;75;175;75 10:24:44 INFO - PROCESS | 15978 | |4;audio-oscillator;93;92;150;92;94;93;149;92;92;143 10:24:44 INFO - PROCESS | 15978 | |5;imaging-gaussian-blur;117;118;117;117;118;118;118;118;118;117 10:24:44 INFO - PROCESS | 15978 | |6;imaging-darkroom;147;146;147;146;147;148;146;146;149;150 10:24:44 INFO - PROCESS | 15978 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;94;96 10:24:44 INFO - PROCESS | 15978 | |8;json-parse-financial;60;57;57;56;58;57;62;76;54;56 10:24:44 INFO - PROCESS | 15978 | |9;json-stringify-tinderbox;59;58;58;58;59;58;60;59;58;60 10:24:44 INFO - PROCESS | 15978 | |10;stanford-crypto-aes;71;73;71;74;73;81;74;73;73;72 10:24:44 INFO - PROCESS | 15978 | |11;stanford-crypto-ccm;129;113;115;114;117;111;115;113;138;130 10:24:44 INFO - PROCESS | 15978 | |12;stanford-crypto-pbkdf2;163;162;169;163;162;162;162;164;179;165 10:24:44 INFO - PROCESS | 15978 | |13;stanford-crypto-sha256-iterative;68;68;68;66;71;66;66;69;64;67 10:24:44 INFO - PROCESS | 15978 | __end_tp_report 10:24:44 INFO - PROCESS | 15978 | __start_cc_report 10:24:44 INFO - PROCESS | 15978 | _x_x_mozilla_cycle_collect,883 10:24:44 INFO - PROCESS | 15978 | __end_cc_report 10:24:44 INFO - PROCESS | 15978 | __startTimestamp1464629084164__endTimestamp 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | ------- Summary: start ------- 10:24:44 INFO - PROCESS | 15978 | Number of tests: 14 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.82 (3.5%) stddev-sans-first:4.06 10:24:44 INFO - PROCESS | 15978 | Values: 109.0 111.0 103.0 113.0 110.0 112.0 101.0 109.0 110.0 110.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:157.00 stddev:19.08 (12.2%) stddev-sans-first:19.94 10:24:44 INFO - PROCESS | 15978 | Values: 158.0 129.0 157.0 177.0 131.0 157.0 153.0 128.0 172.0 125.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 10:24:44 INFO - PROCESS | 15978 | Values: 163.0 162.0 162.0 162.0 163.0 162.0 163.0 162.0 163.0 163.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#3] audio-fft Cycles:10 Average:97.70 Median:76.00 stddev:44.92 (59.1%) stddev-sans-first:46.67 10:24:44 INFO - PROCESS | 15978 | Values: 72.0 77.0 78.0 190.0 83.0 77.0 75.0 75.0 175.0 75.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:26.52 (28.8%) stddev-sans-first:27.49 10:24:44 INFO - PROCESS | 15978 | Values: 93.0 92.0 150.0 92.0 94.0 93.0 149.0 92.0 92.0 143.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:24:44 INFO - PROCESS | 15978 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.40 (1.0%) stddev-sans-first:1.48 10:24:44 INFO - PROCESS | 15978 | Values: 147.0 146.0 147.0 146.0 147.0 148.0 146.0 146.0 149.0 150.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:24:44 INFO - PROCESS | 15978 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 94.0 96.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.50 stddev:6.27 (10.9%) stddev-sans-first:6.65 10:24:44 INFO - PROCESS | 15978 | Values: 60.0 57.0 57.0 56.0 58.0 57.0 62.0 76.0 54.0 56.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 10:24:44 INFO - PROCESS | 15978 | Values: 59.0 58.0 58.0 58.0 59.0 58.0 60.0 59.0 58.0 60.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:73.00 stddev:2.84 (3.9%) stddev-sans-first:2.86 10:24:44 INFO - PROCESS | 15978 | Values: 71.0 73.0 71.0 74.0 73.0 81.0 74.0 73.0 73.0 72.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:116.00 stddev:9.29 (8.0%) stddev-sans-first:9.19 10:24:44 INFO - PROCESS | 15978 | Values: 129.0 113.0 115.0 114.0 117.0 111.0 115.0 113.0 138.0 130.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:163.50 stddev:5.34 (3.3%) stddev-sans-first:5.61 10:24:44 INFO - PROCESS | 15978 | Values: 163.0 162.0 169.0 163.0 162.0 162.0 162.0 164.0 179.0 165.0 10:24:44 INFO - PROCESS | 15978 | 10:24:44 INFO - PROCESS | 15978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.95 (2.9%) stddev-sans-first:2.05 10:24:44 INFO - PROCESS | 15978 | Values: 68.0 68.0 68.0 66.0 71.0 66.0 66.0 69.0 64.0 67.0 10:24:44 INFO - PROCESS | 15978 | -------- Summary: end -------- 10:24:44 INFO - PROCESS | 15978 | 10:24:45 INFO - TEST-INFO | 15978: exit 0 10:24:45 INFO - TEST-OK | kraken | took 60638ms 10:24:45 INFO - SUITE-END | took 1169s 10:24:45 INFO - Completed test suite (00:19:29) 10:24:45 INFO - javascript benchmark 10:24:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3409.3692666856628, 3438.1748380388713, 3447.741419393546, 3473.9925421627713, 3480.947785783212, 5686.971565142174, 5711.314642242936, 5739.827805165846, 5777.82666520004, 5782.479576838084, 5733.111367738007, 5799.072148456248, 5799.942000579993, 5801.216835727176, 5802.274715660543, 5191.402988656297, 5230.450802665722, 5268.420473747885, 5307.65500242483, 5344.931013797237, 5072.4673909239555, 5183.015227106856, 5372.946270537283, 5389.272448219499, 5390.9191362129595, 5173.327467429229, 5187.170052791555, 5232.869178270555, 5295.285136506561, 5314.096603577382, 5231.450697676765, 5248.580113590922, 5257.894842103136, 5260.447652996419, 5262.289590905255, 5123.795048198068, 5144.228365745131, 5257.605679574009, 5261.15821468567, 5264.499872512105, 5456.727163641842, 5552.3892371839065, 5606.579506536985, 5618.0449323614675, 5647.971760141214, 6015.75936962521, 6047.213862197887, 6061.757529698807, 6069.848253793646, 6082.178905847698, 6043.697815109227, 6107.786227482061, 6117.357677443893, 6118.4799292060225, 6140.078988151813, 5478.260434841325, 5550.27846379972, 5735.627184233012, 5789.276340457485, 5795.681237531934, 6172.444479996821, 6193.752249909953, 6200.906986395207, 6202.751889924352, 6260.060990851409, 5959.374265702126, 5969.074793407029, 5979.342272350038, 5988.8802223956145, 6045.183900173508, 6093.329733729286, 6108.602940808833, 6108.72510737009, 6111.877762444727, 6124.938750612437, 6079.817605471843, 6082.787102451393, 6085.574009819358, 6086.087086936995, 6091.817245482643, 5881.558883083786, 6052.576319657582, 6082.7262773174425, 6127.464420129056, 6135.447809697149, 4675.836345727883, 4694.0, 4700.341952126705, 4700.435947686299, 4711.151992641289, 4166.604172603597, 4175.373693945932, 4206.72656277341, 4207.368894665825, 4244.893877653021, 5781.53747700183, 5820.417958204146, 5841.912371314434, 5862.355140934494, 5893.499052580579, 6050.6672133032225, 6250.562460627803, 6318.08387783778, 6324.2410910691015, 6347.650879201688, 5628.352739434936, 5866.677332746654, 5892.499137573269, 5915.40845915405, 5931.6441013539325, 5045.091883460939, 5104.897902041938, 5110.0, 5140.640155189101, 5158.690478571298, 6308.432241098323, 6326.051092336186, 6350.0792385103905, 6351.2696039956, 6363.618182908947, 6063.909041364295, 6127.264728232641, 6132.141500190066, 6143.600665956787, 6151.138840562415, 6302.5588208826775, 6368.0, 6412.326705695835, 6414.0, 6430.678466076771, 6098.817035488943, 6102.572819902564, 6117.938820611737, 6130.509559235161, 6133.26400831903, 5938.910916336345, 6073.848153796013, 6174.6912654368, 6205.751769929152, 6237.376262373727, 5977.252843394575, 5989.880202395841, 6009.2188015557695, 6018.578699491169, 6059.212302400836, 5965.403459654, 5992.041273396236, 6031.577789554689, 6032.426919442646, 6041.24484439445, 5779.768809247751, 5829.766809327749, 5882.911756323744, 5961.731722072604, 5963.403659634002, 5848.64908105515, 5890.293164820249, 5892.7642894283745, 5910.290765108042, 5938.138969849434, 5785.537157027344, 5789.913151302818, 5791.9131213031, 5804.593678442468, 5807.738651760596], "value": 5648.301942066963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.5221987948797, 670.7250027488731, 673.1014096181598, 718.1848601836916, 736.0027163193872, 40616.0, 41335.79332103335, 41339.58660413395, 41722.58277417229, 41731.58268417315, 44727.0, 45043.77478112613, 45177.77411112948, 45214.417495387665, 45384.773076134574, 8814.382993190478, 8944.150305720947, 8972.0, 8982.775430614221, 8995.955020224923, 8817.16236957488, 8963.10368963105, 8978.147076027766, 9218.262538996898, 9220.400673956205, 9159.175674189322, 9178.54107294636, 9208.171264586186, 9212.585433655502, 9215.2627789777, 9135.36052476327, 9157.496337701425, 9217.216536594398, 9226.81546369069, 9233.53832308382, 9065.546722663841, 9125.133112354315, 9151.725448236564, 9197.67808126719, 9204.401713888576, 45141.322880156826, 45568.0, 45746.0, 45795.77102114502, 45809.08381832378, 3709.9443508347395, 3876.2441323941844, 3962.1085255817497, 4158.251514727348, 4399.780010999437, 34123.0, 34191.48712769311, 34542.309153817034, 34711.82644086763, 34724.652753472394, 4321.65426765858, 4372.89067773305, 4391.73649581023, 4406.206882761102, 4439.800208990603, 334338.0, 334406.0, 335824.99999999756, 336750.0, 337627.0, 66338.66830665816, 66536.0, 66663.0, 66692.66653666798, 66818.0, 72402.27597724061, 73976.0, 74024.62987685027, 74226.62886685532, 74322.6283868588, 18911.24355025811, 19042.809571904105, 19061.332853350345, 19110.904445477685, 19169.52076198106, 14396.784048239284, 14439.639009024859, 14511.564653060213, 14525.0, 14535.709285814224, 20714.58570828575, 20952.89523552403, 20974.370768876957, 21048.684269735968, 21085.89457052705, 7291.34377905991, 7475.318757744045, 7477.850442991218, 7535.8116047098165, 7748.457607967388, 1062.081299675775, 1065.9467026648636, 1113.7494063835572, 1174.4949671641277, 1221.712897469094, 33850.66149338525, 33997.490037649455, 34073.0, 34126.0, 34159.01988988632, 1178.793711100571, 1191.713988642737, 1198.2930071258, 1253.4547471849774, 1258.3708145927037, 15855.603609909844, 15936.521904342888, 16015.839841601668, 16123.677526449404, 16187.514374568782, 379786.0, 575408.0, 576700.0, 582893.0, 591701.0, 65348.67325663341, 66386.33613663899, 66399.0, 66718.33281667218, 66808.0, 1518.7418138916412, 1519.0885468718902, 1519.7036577867432, 1527.8013858198362, 1632.4041724770373, 32913.50629740508, 33453.0, 34312.0, 34414.48378274378, 34503.309933801684, 56193.0, 56738.0, 56869.43130568641, 57033.42966570281, 57279.71360143173, 482266.0, 484089.0, 487568.0, 488170.0, 488222.0, 31625.683743162273, 32206.19484512906, 32230.83884580562, 32477.35045299128, 32590.51114233241, 51387.515852331526, 52329.47670523398, 52562.0, 52776.73611632071, 53533.46466535285, 43294.0, 43600.0, 44084.0, 44101.77949110234, 45190.77404612956, 42872.0, 44270.98939294056, 44545.0, 44708.55291447174, 45281.32078018766, 45347.31979020251, 45658.0, 45809.77095114503, 46059.0, 46101.0, 36261.456078159375, 36797.44803827998, 37006.814965926074, 37444.43833342448, 37595.0, 27510.17469475919, 29647.851760741058, 29760.0, 29764.255893602833, 30037.0], "value": 21559.436148289027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.6903509777628, 434.91736570051665, 436.39341315571363, 441.6091758793469, 447.9260921947879, 18784.060796960166, 18842.717359239607, 19104.42686719397, 19189.136488858, 19386.0, 19686.507837304038, 19796.0, 20646.174153033862, 20986.37040888772, 21117.366479005617, 5778.971105144468, 5846.941530584693, 6001.189839371673, 6018.458338749533, 6027.306859711123, 5929.911051334212, 5965.642061476304, 5965.791197308095, 5966.492848107916, 5989.700514974255, 5715.371309155989, 5820.505257053155, 5869.090291004901, 5910.024845900442, 5937.940620593804, 5854.18041474194, 5885.234919460486, 5907.940920590782, 5916.230889984275, 5929.377415371388, 5357.491038351351, 5480.479354461319, 5733.827985160452, 5756.338021127582, 5757.165211044375, 14332.64168395788, 14586.41654333836, 14766.409343626243, 14799.40802367904, 14938.0, 2430.9149179778624, 2447.8164137689746, 2496.6504689343506, 2652.7877769778565, 3182.204448887778, 10579.788404231873, 10584.0, 10624.09695175911, 10722.892771072267, 10788.73028174294, 1951.990240048805, 1978.1395093134533, 2019.9496261943707, 2020.5554777948828, 2104.726385569866, 79644.0, 81116.59441702813, 81975.0, 83222.58388708078, 84074.0, 11465.598704045486, 11686.824697629543, 11714.589989350503, 11912.166148369704, 11927.210918362314, 16559.83440165583, 16609.501714948572, 16710.164491775362, 16725.163741813103, 16793.244304006348, 8657.95671021641, 8783.824323513494, 8817.955910220537, 8833.0, 8920.375573709907, 8375.8324833503, 8437.704680336159, 8447.0, 8560.0, 8642.265407440313, 4773.331733557305, 5106.391486681683, 5146.150885103991, 5185.2999845021195, 5200.791968321225, 2128.6062078515524, 2141.1114387529315, 2142.7964343387353, 2194.2758889566403, 2218.8003079722903, 983.6852207293597, 1035.3787727363522, 1065.9307145035548, 1095.6895612288329, 1152.3546813784308, 18656.813431865507, 19091.331803387093, 19460.31888883882, 19491.902540487208, 19644.508887277647, 1080.1844607321423, 1107.9778404431866, 1113.1373185780922, 1113.7883802077579, 1121.0359091181576, 10632.946835265775, 10929.672109836718, 10986.670399888017, 10988.340699558052, 11017.173711971634, 543823.0, 572175.0, 573485.0, 596917.0, 600945.0, 75805.0, 92921.5353923226, 101210.0, 101586.0, 101945.49027254817, 1020.7652239984845, 1032.4579595712312, 1040.1107053469175, 1068.887766784492, 1077.375122429005, 17416.564585885455, 17658.381956631456, 17677.204525796114, 17769.73345399846, 18134.0, 37901.62098379091, 38348.0, 38407.80796096002, 41119.38320925248, 41985.58014419817, 57143.14285285641, 59338.40661593329, 60079.0, 60190.39809602023, 60202.096968546386, 9041.728748137566, 9176.265898727952, 9212.815743685223, 9298.95350523243, 9445.527723613654, 12094.637160884835, 13208.27354495512, 13345.599632011055, 13477.730445391233, 13532.729345413234, 11712.238704484182, 11834.585789497327, 11859.34773587461, 11975.820362694742, 12104.818427723416, 11529.711757206136, 11537.826932596186, 11701.590444334748, 11862.288262704265, 11923.582674606347, 11804.468798904241, 11849.881501185222, 11996.460159292677, 11996.64010079699, 12162.148649594443, 9011.729648110568, 9023.4134781239, 9189.632414703337, 9319.34764566501, 9337.766555836159, 10334.844977325196, 11725.120615953667, 11813.82279265829, 11835.112366572714, 12062.276263424223], "value": 9511.129790216179, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.277479584595, 1552.6739384729206, 1747.868909831763, 1839.779226492821, 1908.1031914999944, 7718.0, 8440.746777596667, 8575.056743758189, 8762.605682744284, 8775.429597076185, 8519.914800852006, 8534.786630334245, 8599.0, 8612.655493780258, 8637.222649961503, 2418.2866054513875, 2427.0170580914714, 2429.8822541630784, 2431.3678443604704, 2440.04838113136, 2364.137089962169, 2386.093284551868, 2423.660687503751, 2428.5992811186134, 2434.500927309897, 2374.6675465434855, 2390.40239940015, 2414.903403863852, 2449.081594402099, 2449.9265022049276, 2389.8207634427486, 2396.880155992202, 2397.7961873240797, 2399.956019131683, 2432.1365915100237, 2348.5537747827857, 2386.4033991502124, 2388.522295540899, 2393.3298676370646, 2404.1224952892244, 8794.86807697885, 8816.206541411304, 8833.779155521099, 8840.911590884074, 8877.201051905295, 5348.598855085846, 5466.508014278695, 5485.780568777244, 5496.6701997880255, 5501.5323697485765, 3370.3764803511185, 3385.9830700846583, 3402.4556071028765, 3538.8938331850086, 3551.271989242199, 1099.9725006874812, 1105.4030823355379, 1107.0, 1123.8314252862053, 1150.442035612727, 12426.689332766753, 12443.813342799865, 12469.812952805714, 12482.625521234288, 12518.812217816649, 4687.5781179693995, 4760.262159365304, 4783.162946484351, 4798.520147985243, 4829.444613869379, 10436.37381757097, 10547.103496202908, 10583.523741431654, 10623.628173013907, 10651.467426628638, 5511.145772405283, 5563.304586926634, 5572.4706152915405, 5583.330000399978, 5592.440755924375, 4275.5296917339065, 4819.963707802769, 4825.034993001414, 4908.582770464551, 5076.466970968069, 4109.958900411018, 4155.937660935088, 4230.386593943861, 4392.626626736699, 4398.3842262083335, 1321.5859030836912, 1326.1247576599399, 1330.720548684787, 1332.1807088640417, 1336.5188532128425, 1040.7346126737634, 1050.5902697947806, 1054.1092776603757, 1070.9518071686794, 1083.539495714334, 6164.599301045418, 6165.106059621419, 6297.685115744286, 6318.684065796691, 6413.35866413355, 453.3019150508246, 454.07368967306326, 454.4773510462994, 1080.7946490166844, 1120.7254222715324, 4107.979460102681, 4166.687498437569, 4183.790810459464, 4193.18232944579, 4195.244855925963, 10728.302660327054, 10973.286736362112, 11173.273737207219, 11188.049015833745, 11189.552417903356, 11080.501377437873, 11086.33481991067, 11111.666650000512, 11119.72200694989, 11127.666170014912, 8430.241278284984, 8483.06686264498, 8576.1423857615, 8588.969323681198, 8594.656213751505, 6090.147379366981, 6113.23584551931, 6128.540359472968, 6245.344238854855, 6289.591176573508, 9370.906290937004, 9846.704598862045, 9887.406755594688, 9918.107370336416, 9989.60041598328, 10002.29983901149, 10011.749706257111, 10072.143867771028, 10118.0, 10174.8473772892, 6934.549254298455, 7504.812379690551, 7678.731244406419, 7741.651625676745, 7832.84334313322, 8296.460730052528, 8303.543305118277, 8354.5405002723, 8402.747917562483, 8412.873806893023, 7438.814029649302, 7610.124835643972, 7656.119546252029, 7727.806804829699, 7837.098733645704, 7224.566526008456, 7407.333339999426, 7418.851622967619, 7443.032405787213, 7471.88792168107, 7135.143782746104, 7179.246179151322, 7198.748043818441, 7232.0, 7281.126264848041, 5090.592752579711, 5150.639455238097, 5156.690598564098, 5265.447128051653, 5287.735613219401, 5213.191955246943, 5234.947650523598, 5342.065138600807, 5386.299781028598, 5434.076207044891], "value": 4701.992493936717, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9982500087499, 350.87543921907724, 357.2016543026336, 363.8508211633229, 368.2653107051433, 6617.106690596768, 6789.117414736077, 6796.320367963207, 6819.659017049153, 6843.144606924135, 6619.238787539434, 6652.234992975809, 6656.134702488682, 6663.167104111986, 6676.532642715012, 4845.660803743739, 5068.72122033288, 5077.695338279696, 5078.619103567229, 5084.415292241393, 5005.57452616528, 5018.422881368635, 5023.296738456619, 5047.520485553867, 5051.974740126294, 4965.957148998715, 4966.180580204262, 4974.1295273327205, 4988.376452943382, 4992.375953005874, 4979.427365852919, 4985.700857948535, 4988.950110498885, 5008.524190201925, 5015.548600625924, 4262.957370426287, 4321.956780432219, 4322.286822674255, 4331.610155086026, 4336.046069864625, 6419.293877673452, 6428.260750013715, 6432.388923052349, 6437.517186211053, 6443.9355606443805, 5577.274954255961, 5696.544276457874, 5699.2306038684665, 5710.2862142232225, 5847.356790753014, 6930.72277108915, 6954.7133780250815, 6958.686859091353, 6965.860682786316, 6980.511364204508, 4716.339712440261, 4729.43246810385, 4765.213739732974, 4772.141014617368, 4774.188387974018, 7318.231585683479, 7336.559806411632, 7347.448941329421, 7391.186969433358, 7396.815079622998, 4803.327534145223, 4903.705777653281, 4925.655204135676, 4928.310036594879, 4945.505449455098, 4960.255961605716, 4960.330355402047, 4991.675541089818, 4993.350864387607, 4995.825146119941, 5717.085266357363, 5807.070868661079, 5816.069428891357, 5821.243238378984, 5827.854303642443, 7045.225025247219, 7065.646717664096, 7095.3968912643, 7103.0, 7104.183018952784, 1735.7569940208382, 1754.8683848711398, 1756.3852651572104, 1763.1272520102375, 1765.13508380895, 1113.1373185781085, 1136.9260998035268, 1144.9026832719146, 1148.3224897310627, 1159.4724400397968, 6808.489363297773, 6821.488388370892, 6823.658817059227, 6823.897641535381, 6845.383915447634, 7293.197748247689, 7295.088113985752, 7303.561786292839, 7318.926810731931, 7356.889646655304, 6676.6327851967635, 6789.966050169717, 6805.319468053155, 6890.689918953659, 6936.306369363124, 3965.7422267552515, 3993.4409182714444, 4002.3596224603925, 4012.6789856811383, 4016.7991600419864, 7700.961495192488, 7724.7682569523, 7732.226777322223, 7747.30274275318, 7764.8058798529355, 7565.848683026308, 7569.583672898044, 7592.696292148363, 7621.618919054025, 7636.121845987672, 7416.888746668804, 7613.961930190314, 7616.0860696716745, 7617.314441700273, 7677.385809135256, 7272.345488906024, 7316.780496585111, 7318.3047610476915, 7320.084989376328, 7332.266773322838, 7231.963840180765, 7258.419326453976, 7274.418046556369, 7290.890636640349, 7325.267473252632, 7666.540007599562, 7707.730229441942, 7715.267049630276, 7715.884261736191, 7721.92278077212, 4779.115863565252, 4951.430585482715, 4954.950450495449, 4959.380077490314, 4963.503649635008, 7300.744473943387, 7333.413326933939, 7334.853302934018, 7342.853142937218, 7391.6304184791625, 7074.575525468488, 7082.18554866197, 7087.397571206505, 7088.64556772149, 7113.644317784194, 6948.374646281859, 6988.580685158907, 7018.0, 7018.824529386806, 7022.262662420372, 6930.653467326512, 6939.236683964861, 6947.617881016593, 6951.860962780817, 6957.582545047313, 7118.074650295428, 7128.358447739728, 7138.785836424916, 7140.892886606601, 7158.141023077264, 6933.722651094102, 6935.202451718117, 6940.0, 6951.096357473496, 6952.165740111219], "value": 5302.721909616085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.5892053973012, 831.9584020798959, 861.2378045429795, 877.1141147441083, 915.7573243090582, 13966.581002569927, 14229.573112806607, 15822.604434889105, 15838.920805395986, 15844.920775396136, 13539.0, 13587.796183057237, 13605.183688978668, 13752.587422377319, 13827.516036938709, 874.6020560644923, 907.7912080221553, 908.6592527802075, 908.9181973622373, 909.7998440343147, 908.0601577367426, 908.8636704494313, 913.6071489259616, 916.665417122752, 919.1130559010553, 948.2224575847807, 954.3367359685021, 954.7422196007074, 956.4022485946283, 958.420155805738, 948.2319321349694, 949.8100379924008, 950.4724877692878, 952.1383148250844, 958.5446912716474, 703.1527009952995, 706.0362605044129, 706.1631966120112, 706.6572712234562, 708.6952610377588, 13844.169349839041, 13850.238236896967, 13885.652858678513, 13922.0, 13946.58160255194, 14436.133831970115, 14713.337899794535, 14775.70448591033, 14823.407063717439, 14851.183184924825, 11767.23512971654, 11916.940415297868, 12194.81707774384, 12336.383180840921, 12529.624111276586, 3998.7200895937294, 4056.4320995060716, 4063.045184381668, 4094.160697057126, 4098.610631989986, 59136.11295830566, 59359.99999999957, 59378.40621593772, 59450.0, 59479.0, 10545.736356590993, 10748.301360411548, 10758.274734626275, 10862.891371086345, 10916.399598022026, 18932.526686832665, 18990.71513927292, 19020.42938711841, 19022.144003519876, 19045.523861903563, 8508.10664880191, 8588.828223435621, 8605.354598405145, 8640.481571105754, 8643.438176518506, 5025.6482046256415, 5030.647854650212, 5051.797928082909, 5075.898482030412, 5119.0529751995255, 3498.5626796650417, 3526.858925642997, 3532.7350448716447, 3535.911602209965, 3573.1245844767677, 599.7031469422664, 610.6854969690613, 623.5136593457111, 625.7497001199465, 626.9404406581367, 752.9360004399578, 812.2689579378607, 832.3216578488513, 854.3933806996978, 866.8006358537572, 8914.910850891538, 8961.462312261285, 9679.70960871175, 9680.322377433513, 9757.121859032579, 751.9210482899326, 764.8699721047435, 776.4293244465314, 803.269025187077, 823.9823817585277, 4469.351943968107, 4538.591526762541, 4672.836450724276, 4714.316424118484, 4746.976265118652, 66822.33177668258, 69323.65338173277, 69834.0, 69940.30059699439, 70209.0, 51026.23460648093, 59354.70322648445, 60009.399906000384, 60363.09455358173, 60443.09335359973, 54918.72540637351, 55393.723031385394, 56115.0, 56592.0, 56633.433665662815, 9684.806303874024, 9829.115379615869, 9845.0, 10086.0, 10340.689779306633, 38981.6101838978, 40207.396889046104, 40656.39015414712, 40938.1812363757, 41760.79119604383, 47741.52258477371, 52672.473275266755, 52803.0, 53059.0, 53969.730151348995, 12767.80848287295, 12806.487740490276, 13070.54253101137, 13327.866721332663, 13504.257265850472, 13831.100978436369, 14507.782383264048, 14837.258137093319, 15039.398424062914, 15481.148536830582, 13165.602103137668, 13646.658833528843, 13774.724505510034, 14009.229492378017, 14633.122012679274, 12640.178388404724, 12713.50274040857, 12948.09363344557, 13939.372728227052, 14096.026556281924, 13656.726865462833, 13882.236476993863, 13992.720145597235, 14076.296185190495, 14360.784588230976, 10715.785684286426, 10857.945710271399, 11245.269057511236, 11685.357305348287, 11822.408879555816, 10770.461476926279, 10812.405317707602, 10844.457777110954, 10926.399048052433, 11364.943175284401], "value": 7241.377331404434, "unit": "score"}], "name": "dromaeo_css", "value": 7704.385639357872, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 103.0, 113.0, 110.0, 112.0, 101.0, 109.0, 110.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 157.0, 177.0, 131.0, 157.0, 153.0, 128.0, 172.0, 125.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 163.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 78.0, 190.0, 83.0, 77.0, 75.0, 75.0, 175.0, 75.0], "value": 97.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 150.0, 92.0, 94.0, 93.0, 149.0, 92.0, 92.0, 143.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 149.0, 150.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 56.0, 58.0, 57.0, 62.0, 76.0, 54.0, 56.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 60.0, 59.0, 58.0, 60.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 71.0, 74.0, 73.0, 81.0, 74.0, 73.0, 73.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 113.0, 115.0, 114.0, 117.0, 111.0, 115.0, 113.0, 138.0, 130.0], "value": 119.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 169.0, 163.0, 162.0, 162.0, 162.0, 164.0, 179.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 71.0, 66.0, 66.0, 69.0, 64.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1530.1, "alertThreshold": 2.0}]} 10:24:45 INFO - Return code: 0 10:24:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:24:45 ERROR - # TBPL SUCCESS # 10:24:45 INFO - Running post-action listener: _resource_record_post_action 10:24:45 INFO - Running post-run listener: _resource_record_post_run 10:24:46 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 499535872; Read time: 0; Write time: 508540 10:24:46 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 249135104; Read time: 0; Write time: 340084 10:24:46 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 250400768; Read time: 0; Write time: 168456 10:24:46 INFO - Running post-run listener: _upload_blobber_files 10:24:46 INFO - Blob upload gear active. 10:24:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:24:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:24:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:24:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:24:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:24:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:47 INFO - (blobuploader) - INFO - Done attempting. 10:24:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:24:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:24:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:48 INFO - (blobuploader) - INFO - Done attempting. 10:24:48 INFO - (blobuploader) - INFO - Iteration through files over. 10:24:48 INFO - Return code: 0 10:24:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:24:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:24:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed4bcb980051bf6b8a66a05540705e25f0bfb7aa6567ac893b4909a74014c0d2e01cb70673f88bde64ee487a24febe7e45d67a2c606fe8549b60ee12973379a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718e11a06b3e4b45b39c598cb2364aa888ddf69e0a5ee152cead8019a7d7b718b625a4c32ab77d38b90dffaa576a0ffee69882ebb999c71dea8f5c6081b2f6f7"} 10:24:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:24:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:24:48 INFO - Contents: 10:24:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed4bcb980051bf6b8a66a05540705e25f0bfb7aa6567ac893b4909a74014c0d2e01cb70673f88bde64ee487a24febe7e45d67a2c606fe8549b60ee12973379a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718e11a06b3e4b45b39c598cb2364aa888ddf69e0a5ee152cead8019a7d7b718b625a4c32ab77d38b90dffaa576a0ffee69882ebb999c71dea8f5c6081b2f6f7"} 10:24:48 INFO - Running post-run listener: copy_logs_to_upload_dir 10:24:48 INFO - Copying logs to upload dir... 10:24:48 INFO - mkdir: /builds/slave/test/build/upload/logs 10:24:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.563615 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 10:24:48.343336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:24:48.347242) ========= 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=232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576 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/ed4bcb980051bf6b8a66a05540705e25f0bfb7aa6567ac893b4909a74014c0d2e01cb70673f88bde64ee487a24febe7e45d67a2c606fe8549b60ee12973379a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718e11a06b3e4b45b39c598cb2364aa888ddf69e0a5ee152cead8019a7d7b718b625a4c32ab77d38b90dffaa576a0ffee69882ebb999c71dea8f5c6081b2f6f7"} build_url:https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011555 build_url: 'https://queue.taskcluster.net/v1/task/O7uBMZZZT8KhVD-AAj94OQ/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/ed4bcb980051bf6b8a66a05540705e25f0bfb7aa6567ac893b4909a74014c0d2e01cb70673f88bde64ee487a24febe7e45d67a2c606fe8549b60ee12973379a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718e11a06b3e4b45b39c598cb2364aa888ddf69e0a5ee152cead8019a7d7b718b625a4c32ab77d38b90dffaa576a0ffee69882ebb999c71dea8f5c6081b2f6f7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:24:48.373713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:24:48.374074) ========= 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=232498196343f89f466a4a9a000001c8-1464627667.421559-1479530576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:24:48.425679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:24:48.426006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:24:48.426355) ========= ========= Total master_lag: 0.14 =========