builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1464196116.15 results: success (0) buildid: 20160525073114 builduid: a937a0487ae347e38285e1bd487108af revision: f887875e60c8738740089de8e85d6b68475de96e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.150803) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.151315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.151956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.167677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.168051) ========= 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=7de08804244eb36560b44971000001c3-1464196115.372422-1300823126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 10:08:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.5M=0s 2016-05-25 10:08:36 (26.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095016 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.276813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.277244) ========= 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=7de08804244eb36560b44971000001c3-1464196115.372422-1300823126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017904 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:36.327453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 10:08:36.327818) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f887875e60c8738740089de8e85d6b68475de96e --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 f887875e60c8738740089de8e85d6b68475de96e --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=7de08804244eb36560b44971000001c3-1464196115.372422-1300823126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 10:08:36,338 truncating revision to first 12 chars 2016-05-25 10:08:36,338 Setting DEBUG logging. 2016-05-25 10:08:36,338 attempt 1/10 2016-05-25 10:08:36,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f887875e60c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 10:08:37,505 unpacking tar archive at: mozilla-aurora-f887875e60c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.480261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 10:08:37.821601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:37.821948) ========= script_repo_revision: f887875e60c8738740089de8e85d6b68475de96e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:37.822366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:37.822662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 10:08:37.832037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-25 10:08:37.832341) ========= /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=7de08804244eb36560b44971000001c3-1464196115.372422-1300823126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:37 INFO - MultiFileLogger online at 20160525 10:08:37 in /builds/slave/test 10:08:37 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:08:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:37 INFO - {'append_to_log': False, 10:08:37 INFO - 'base_work_dir': '/builds/slave/test', 10:08:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:08:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:37 INFO - 'branch': 'Mozilla-Aurora', 10:08:37 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:37 INFO - 'config_files': ('talos/linux_config.py',), 10:08:37 INFO - 'default_actions': ('clobber', 10:08:37 INFO - 'read-buildbot-config', 10:08:37 INFO - 'download-and-extract', 10:08:37 INFO - 'populate-webroot', 10:08:37 INFO - 'create-virtualenv', 10:08:37 INFO - 'install', 10:08:37 INFO - 'run-tests'), 10:08:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:37 INFO - 'download_minidump_stackwalk': True, 10:08:37 INFO - 'download_symbols': 'ondemand', 10:08:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:37 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:37 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:37 INFO - 'installer_path': 'installer.exe', 10:08:37 INFO - 'log_level': 'info', 10:08:37 INFO - 'log_name': 'talos', 10:08:37 INFO - 'log_to_console': True, 10:08:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:37 INFO - 'opt_config_files': (), 10:08:37 INFO - 'pip_index': False, 10:08:37 INFO - 'sps_profile': False, 10:08:37 INFO - 'sps_profile_interval': 0, 10:08:37 INFO - 'suite': 'dromaeojs-e10s', 10:08:37 INFO - 'system_bits': '32', 10:08:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:37 INFO - 'title': 'talos-linux64-ix-003', 10:08:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:37 INFO - 'use_talos_json': True, 10:08:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:37 INFO - 'work_dir': 'build'} 10:08:37 INFO - ##### 10:08:37 INFO - ##### Running clobber step. 10:08:37 INFO - ##### 10:08:37 INFO - Running pre-action listener: _resource_record_pre_action 10:08:37 INFO - Running main action method: clobber 10:08:37 INFO - rmtree: /builds/slave/test/build 10:08:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:38 INFO - Running post-action listener: _resource_record_post_action 10:08:38 INFO - ##### 10:08:38 INFO - ##### Running read-buildbot-config step. 10:08:38 INFO - ##### 10:08:38 INFO - Running pre-action listener: _resource_record_pre_action 10:08:38 INFO - Running main action method: read_buildbot_config 10:08:38 INFO - Using buildbot properties: 10:08:38 INFO - { 10:08:38 INFO - "project": "", 10:08:38 INFO - "product": "firefox", 10:08:38 INFO - "script_repo_revision": "production", 10:08:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:08:38 INFO - "repository": "", 10:08:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:08:38 INFO - "buildid": "20160525073114", 10:08:38 INFO - "pgo_build": "True", 10:08:38 INFO - "basedir": "/builds/slave/test", 10:08:38 INFO - "buildnumber": 288, 10:08:38 INFO - "slavename": "talos-linux64-ix-003", 10:08:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:08:38 INFO - "platform": "ubuntu64_hw", 10:08:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:08:38 INFO - "branch": "mozilla-aurora", 10:08:38 INFO - "repo_path": "releases/mozilla-aurora", 10:08:38 INFO - "revision": "f887875e60c8738740089de8e85d6b68475de96e", 10:08:38 INFO - "stage_platform": "linux64-pgo", 10:08:38 INFO - "builduid": "a937a0487ae347e38285e1bd487108af", 10:08:38 INFO - "slavebuilddir": "test" 10:08:38 INFO - } 10:08:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:08:38 INFO - Running post-action listener: _resource_record_post_action 10:08:38 INFO - ##### 10:08:38 INFO - ##### Running download-and-extract step. 10:08:38 INFO - ##### 10:08:38 INFO - Running pre-action listener: _resource_record_pre_action 10:08:38 INFO - Running main action method: download_and_extract 10:08:38 INFO - mkdir: /builds/slave/test/build/tests 10:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:38 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:39 INFO - Downloaded 1361 bytes. 10:08:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:08:39 INFO - Using the following test package requirements: 10:08:39 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:08:39 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:08:39 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:08:39 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'jsshell-linux-x86_64.zip'], 10:08:39 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:08:39 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:08:39 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:08:39 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:08:39 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:08:39 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:08:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:08:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:08: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:08:39 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:40 INFO - Downloaded 24134626 bytes. 10:08:40 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:08:40 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:08:41 INFO - Return code: 0 10:08:41 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:08:41 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:08:41 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:42 INFO - Downloaded 24134626 bytes. 10:08:42 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:08:42 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:08:43 INFO - Return code: 0 10:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:43 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:44 INFO - Downloaded 10840145 bytes. 10:08:44 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:08:44 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:08:45 INFO - Return code: 0 10:08: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:08:45 INFO - https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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:08:48 INFO - Downloaded 62746659 bytes. 10:08:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:08:48 INFO - mkdir: /builds/slave/test/properties 10:08:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:48 INFO - Contents: 10:08:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:08:48 INFO - Running post-action listener: _resource_record_post_action 10:08:48 INFO - Running post-action listener: set_extra_try_arguments 10:08:48 INFO - ##### 10:08:48 INFO - ##### Running populate-webroot step. 10:08:48 INFO - ##### 10:08:48 INFO - Running pre-action listener: _resource_record_pre_action 10:08:48 INFO - Running main action method: populate_webroot 10:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:49 INFO - '--tppagecycles', 10:08:49 INFO - '7'], 10:08:49 INFO - 'tests': ['tsvgm']}}, 10:08:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['damp', 'tps']}, 10:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'tests': ['damp', 'tps']}, 10:08:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['dromaeo_dom']}, 10:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['a11yr', 10:08:49 INFO - 'ts_paint', 10:08:49 INFO - 'tpaint', 10:08:49 INFO - 'sessionrestore', 10:08:49 INFO - 'sessionrestore_no_auto_restore', 10:08:49 INFO - 'tabpaint']}, 10:08:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:49 INFO - 'ts_paint', 10:08:49 INFO - 'tpaint', 10:08:49 INFO - 'sessionrestore', 10:08:49 INFO - 'sessionrestore_no_auto_restore', 10:08:49 INFO - 'tabpaint']}, 10:08:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:49 INFO - 'ts_paint', 10:08:49 INFO - 'tpaint', 10:08:49 INFO - 'sessionrestore', 10:08:49 INFO - 'sessionrestore_no_auto_restore', 10:08:49 INFO - 'tabpaint']}, 10:08:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:49 INFO - 'ts_paint', 10:08:49 INFO - 'tpaint', 10:08:49 INFO - 'sessionrestore', 10:08:49 INFO - 'sessionrestore_no_auto_restore', 10:08:49 INFO - 'tabpaint']}, 10:08:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['a11yr', 10:08:49 INFO - 'ts_paint', 10:08:49 INFO - 'tpaint', 10:08:49 INFO - 'sessionrestore', 10:08:49 INFO - 'sessionrestore_no_auto_restore', 10:08:49 INFO - 'tabpaint']}, 10:08:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['a11yr', 10:08:49 INFO - 'ts_paint', 10:08:49 INFO - 'tpaint', 10:08:49 INFO - 'sessionrestore', 10:08:49 INFO - 'sessionrestore_no_auto_restore', 10:08:49 INFO - 'tabpaint']}, 10:08:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['tsvgx', 10:08:49 INFO - 'tsvgr_opacity', 10:08:49 INFO - 'tart', 10:08:49 INFO - 'tscrollx', 10:08:49 INFO - 'cart']}, 10:08:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:49 INFO - 'tsvgr_opacity', 10:08:49 INFO - 'tart', 10:08:49 INFO - 'tscrollx', 10:08:49 INFO - 'cart']}, 10:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'talos_options': ['--disable-e10s'], 10:08:49 INFO - 'tests': ['tp5o']}, 10:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'tests': ['tp5o']}, 10:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'talos_options': ['--disable-e10s', 10:08:49 INFO - '--xperf_path', 10:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:49 INFO - 'tests': ['tp5n']}, 10:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:49 INFO - 'talos_options': ['--xperf_path', 10:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:49 INFO - 'tests': ['tp5n']}}, 10:08:49 INFO - 'talos.zip': {'path': '', 10:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:49 INFO - Running post-action listener: _resource_record_post_action 10:08:49 INFO - ##### 10:08:49 INFO - ##### Running create-virtualenv step. 10:08:49 INFO - ##### 10:08:49 INFO - Running pre-action listener: _resource_record_pre_action 10:08:49 INFO - Running main action method: create_virtualenv 10:08:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:49 INFO - Using real prefix '/usr' 10:08:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:51 INFO - Installing pip.................done. 10:08:51 INFO - Return code: 0 10:08:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:08:51 INFO - Using env: {'DISPLAY': ':0', 10:08:51 INFO - 'HOME': '/home/cltbld', 10:08:51 INFO - 'LANG': 'en_US.UTF-8', 10:08:51 INFO - 'LANGUAGE': 'en_US:en', 10:08:51 INFO - 'LOGNAME': 'cltbld', 10:08:51 INFO - 'MAIL': '/var/mail/cltbld', 10:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:51 INFO - 'MOZ_NO_REMOTE': '1', 10:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:51 INFO - 'NO_EM_RESTART': '1', 10:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:51 INFO - 'PWD': '/builds/slave/test', 10:08:51 INFO - 'SHELL': '/bin/bash', 10:08:51 INFO - 'SHLVL': '1', 10:08:51 INFO - 'TERM': 'linux', 10:08:51 INFO - 'TMOUT': '86400', 10:08:51 INFO - 'USER': 'cltbld', 10:08:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:51 INFO - '_': '/tools/buildbot/bin/python'} 10:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:51 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:08:51 INFO - Cleaning up... 10:08:51 INFO - Return code: 0 10:08:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:08:51 INFO - Using env: {'DISPLAY': ':0', 10:08:51 INFO - 'HOME': '/home/cltbld', 10:08:51 INFO - 'LANG': 'en_US.UTF-8', 10:08:51 INFO - 'LANGUAGE': 'en_US:en', 10:08:51 INFO - 'LOGNAME': 'cltbld', 10:08:51 INFO - 'MAIL': '/var/mail/cltbld', 10:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:51 INFO - 'MOZ_NO_REMOTE': '1', 10:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:51 INFO - 'NO_EM_RESTART': '1', 10:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:51 INFO - 'PWD': '/builds/slave/test', 10:08:51 INFO - 'SHELL': '/bin/bash', 10:08:51 INFO - 'SHLVL': '1', 10:08:51 INFO - 'TERM': 'linux', 10:08:51 INFO - 'TMOUT': '86400', 10:08:51 INFO - 'USER': 'cltbld', 10:08:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:51 INFO - '_': '/tools/buildbot/bin/python'} 10:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:51 INFO - Downloading/unpacking psutil>=0.7.1 10:08:51 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:08:51 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:08:51 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:08:51 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:08:51 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:08:51 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:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:54 INFO - Installing collected packages: psutil 10:08:54 INFO - Running setup.py install for psutil 10:08:54 INFO - building 'psutil._psutil_linux' extension 10:08:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:08:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:08:54 INFO - building 'psutil._psutil_posix' extension 10:08:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:08:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:54 INFO - Successfully installed psutil 10:08:54 INFO - Cleaning up... 10:08:54 INFO - Return code: 0 10:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:08:54 INFO - Using env: {'DISPLAY': ':0', 10:08:54 INFO - 'HOME': '/home/cltbld', 10:08:54 INFO - 'LANG': 'en_US.UTF-8', 10:08:54 INFO - 'LANGUAGE': 'en_US:en', 10:08:54 INFO - 'LOGNAME': 'cltbld', 10:08:54 INFO - 'MAIL': '/var/mail/cltbld', 10:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:54 INFO - 'MOZ_NO_REMOTE': '1', 10:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:54 INFO - 'NO_EM_RESTART': '1', 10:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:54 INFO - 'PWD': '/builds/slave/test', 10:08:54 INFO - 'SHELL': '/bin/bash', 10:08:54 INFO - 'SHLVL': '1', 10:08:54 INFO - 'TERM': 'linux', 10:08:54 INFO - 'TMOUT': '86400', 10:08:54 INFO - 'USER': 'cltbld', 10:08:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:54 INFO - '_': '/tools/buildbot/bin/python'} 10:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:08: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:08: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:08: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:08: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:08: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:08: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:08:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:08:56 INFO - Installing collected packages: mozsystemmonitor 10:08:56 INFO - Running setup.py install for mozsystemmonitor 10:08:56 INFO - Successfully installed mozsystemmonitor 10:08:56 INFO - Cleaning up... 10:08:56 INFO - Return code: 0 10:08:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08:56 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:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:56 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:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:56 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 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:08:56 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:08:56 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:08:56 INFO - Using env: {'DISPLAY': ':0', 10:08:56 INFO - 'HOME': '/home/cltbld', 10:08:56 INFO - 'LANG': 'en_US.UTF-8', 10:08:56 INFO - 'LANGUAGE': 'en_US:en', 10:08:56 INFO - 'LOGNAME': 'cltbld', 10:08:56 INFO - 'MAIL': '/var/mail/cltbld', 10:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:56 INFO - 'MOZ_NO_REMOTE': '1', 10:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:56 INFO - 'NO_EM_RESTART': '1', 10:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:56 INFO - 'PWD': '/builds/slave/test', 10:08:56 INFO - 'SHELL': '/bin/bash', 10:08:56 INFO - 'SHLVL': '1', 10:08:56 INFO - 'TERM': 'linux', 10:08:56 INFO - 'TMOUT': '86400', 10:08:56 INFO - 'USER': 'cltbld', 10:08:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:56 INFO - '_': '/tools/buildbot/bin/python'} 10:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:08: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:08: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:08: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:08: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:08: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:08: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:08:58 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:59 INFO - Downloading docopt-0.6.1.tar.gz 10:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:59 INFO - Running setup.py install for blobuploader 10:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:59 INFO - Running setup.py install for requests 10:09:00 INFO - Running setup.py install for docopt 10:09:00 INFO - Successfully installed blobuploader requests docopt 10:09:00 INFO - Cleaning up... 10:09:00 INFO - Return code: 0 10:09:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:09:00 INFO - Using env: {'DISPLAY': ':0', 10:09:00 INFO - 'HOME': '/home/cltbld', 10:09:00 INFO - 'LANG': 'en_US.UTF-8', 10:09:00 INFO - 'LANGUAGE': 'en_US:en', 10:09:00 INFO - 'LOGNAME': 'cltbld', 10:09:00 INFO - 'MAIL': '/var/mail/cltbld', 10:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:00 INFO - 'MOZ_NO_REMOTE': '1', 10:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:00 INFO - 'NO_EM_RESTART': '1', 10:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:00 INFO - 'PWD': '/builds/slave/test', 10:09:00 INFO - 'SHELL': '/bin/bash', 10:09:00 INFO - 'SHLVL': '1', 10:09:00 INFO - 'TERM': 'linux', 10:09:00 INFO - 'TMOUT': '86400', 10:09:00 INFO - 'USER': 'cltbld', 10:09:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:00 INFO - '_': '/tools/buildbot/bin/python'} 10:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:00 INFO - Running setup.py (path:/tmp/pip-vODWsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:00 INFO - Running setup.py (path:/tmp/pip-2RICdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:00 INFO - Running setup.py (path:/tmp/pip-cpnKK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:00 INFO - Running setup.py (path:/tmp/pip-2kBcrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:01 INFO - Running setup.py (path:/tmp/pip-I9hEDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:01 INFO - Running setup.py (path:/tmp/pip-d3Kri5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:01 INFO - Running setup.py (path:/tmp/pip-b0KTyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:01 INFO - Running setup.py (path:/tmp/pip-C8Ijwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:01 INFO - Running setup.py (path:/tmp/pip-Pwp7Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:01 INFO - Running setup.py (path:/tmp/pip-z8mxjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:01 INFO - Running setup.py (path:/tmp/pip-eaUvxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:01 INFO - Running setup.py (path:/tmp/pip-tpIzgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:01 INFO - Running setup.py (path:/tmp/pip-QH5elZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:01 INFO - Running setup.py (path:/tmp/pip-6vt4du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:01 INFO - Running setup.py (path:/tmp/pip-VVT46N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:01 INFO - Running setup.py (path:/tmp/pip-YJ4USE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:01 INFO - Running setup.py (path:/tmp/pip-oy9GlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:01 INFO - Running setup.py install for manifestparser 10:09:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozcrash 10:09:02 INFO - Running setup.py install for mozdebug 10:09:02 INFO - Running setup.py install for mozdevice 10:09:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozfile 10:09:02 INFO - Running setup.py install for mozhttpd 10:09:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozinfo 10:09:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozInstall 10:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozleak 10:09:02 INFO - Running setup.py install for mozlog 10:09:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for moznetwork 10:09:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozprocess 10:09:03 INFO - Running setup.py install for mozprofile 10:09:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozrunner 10:09:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozscreenshot 10:09:03 INFO - Running setup.py install for moztest 10:09:03 INFO - Running setup.py install for mozversion 10:09:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:03 INFO - Cleaning up... 10:09:03 INFO - Return code: 0 10:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:09:03 INFO - Using env: {'DISPLAY': ':0', 10:09:03 INFO - 'HOME': '/home/cltbld', 10:09:03 INFO - 'LANG': 'en_US.UTF-8', 10:09:03 INFO - 'LANGUAGE': 'en_US:en', 10:09:03 INFO - 'LOGNAME': 'cltbld', 10:09:03 INFO - 'MAIL': '/var/mail/cltbld', 10:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:03 INFO - 'MOZ_NO_REMOTE': '1', 10:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:03 INFO - 'NO_EM_RESTART': '1', 10:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:03 INFO - 'PWD': '/builds/slave/test', 10:09:03 INFO - 'SHELL': '/bin/bash', 10:09:03 INFO - 'SHLVL': '1', 10:09:03 INFO - 'TERM': 'linux', 10:09:03 INFO - 'TMOUT': '86400', 10:09:03 INFO - 'USER': 'cltbld', 10:09:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:03 INFO - '_': '/tools/buildbot/bin/python'} 10:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:03 INFO - Running setup.py (path:/tmp/pip-x0hB1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:04 INFO - Running setup.py (path:/tmp/pip-x3CljA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:04 INFO - Running setup.py (path:/tmp/pip-QAslF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:04 INFO - Running setup.py (path:/tmp/pip-8uQ8jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:04 INFO - Running setup.py (path:/tmp/pip-zTx62I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:04 INFO - Running setup.py (path:/tmp/pip-fq3ygV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:04 INFO - Running setup.py (path:/tmp/pip-BYFqdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:04 INFO - Running setup.py (path:/tmp/pip-90Pbp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:04 INFO - Running setup.py (path:/tmp/pip-FAadln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:04 INFO - Running setup.py (path:/tmp/pip-4mdrXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:04 INFO - Running setup.py (path:/tmp/pip-21Hl4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:04 INFO - Running setup.py (path:/tmp/pip-8dQiVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:04 INFO - Running setup.py (path:/tmp/pip-rChVhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:04 INFO - Running setup.py (path:/tmp/pip-BrcXcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:04 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:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:04 INFO - Running setup.py (path:/tmp/pip-tkAfwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:05 INFO - Running setup.py (path:/tmp/pip-KgDoOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:05 INFO - Running setup.py (path:/tmp/pip-yTUWcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:07 INFO - Downloading blessings-1.6.tar.gz 10:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:07 INFO - Installing collected packages: blessings 10:09:07 INFO - Running setup.py install for blessings 10:09:07 INFO - Successfully installed blessings 10:09:07 INFO - Cleaning up... 10:09:07 INFO - Return code: 0 10:09:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:07 INFO - Reading from file tmpfile_stdout 10:09:07 INFO - Current package versions: 10:09:07 INFO - argparse == 1.2.1 10:09:07 INFO - blessings == 1.6 10:09:07 INFO - blobuploader == 1.2.4 10:09:07 INFO - docopt == 0.6.1 10:09:07 INFO - manifestparser == 1.1 10:09:07 INFO - mozInstall == 1.12 10:09:07 INFO - mozcrash == 0.17 10:09:07 INFO - mozdebug == 0.1 10:09:07 INFO - mozdevice == 0.48 10:09:07 INFO - mozfile == 1.2 10:09:07 INFO - mozhttpd == 0.7 10:09:07 INFO - mozinfo == 0.9 10:09:07 INFO - mozleak == 0.1 10:09:07 INFO - mozlog == 3.1 10:09:07 INFO - moznetwork == 0.27 10:09:07 INFO - mozprocess == 0.22 10:09:07 INFO - mozprofile == 0.28 10:09:07 INFO - mozrunner == 6.11 10:09:07 INFO - mozscreenshot == 0.1 10:09:07 INFO - mozsystemmonitor == 0.0 10:09:07 INFO - moztest == 0.7 10:09:07 INFO - mozversion == 1.4 10:09:07 INFO - psutil == 3.1.1 10:09:07 INFO - requests == 1.2.3 10:09:07 INFO - wsgiref == 0.1.2 10:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:09:07 INFO - Using env: {'DISPLAY': ':0', 10:09:07 INFO - 'HOME': '/home/cltbld', 10:09:07 INFO - 'LANG': 'en_US.UTF-8', 10:09:07 INFO - 'LANGUAGE': 'en_US:en', 10:09:07 INFO - 'LOGNAME': 'cltbld', 10:09:07 INFO - 'MAIL': '/var/mail/cltbld', 10:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:07 INFO - 'MOZ_NO_REMOTE': '1', 10:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:07 INFO - 'NO_EM_RESTART': '1', 10:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:07 INFO - 'PWD': '/builds/slave/test', 10:09:07 INFO - 'SHELL': '/bin/bash', 10:09:07 INFO - 'SHLVL': '1', 10:09:07 INFO - 'TERM': 'linux', 10:09:07 INFO - 'TMOUT': '86400', 10:09:07 INFO - 'USER': 'cltbld', 10:09:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:07 INFO - '_': '/tools/buildbot/bin/python'} 10:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:09:07 INFO - Cleaning up... 10:09:07 INFO - Return code: 0 10:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:09:07 INFO - Using env: {'DISPLAY': ':0', 10:09:07 INFO - 'HOME': '/home/cltbld', 10:09:07 INFO - 'LANG': 'en_US.UTF-8', 10:09:07 INFO - 'LANGUAGE': 'en_US:en', 10:09:07 INFO - 'LOGNAME': 'cltbld', 10:09:07 INFO - 'MAIL': '/var/mail/cltbld', 10:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:07 INFO - 'MOZ_NO_REMOTE': '1', 10:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:07 INFO - 'NO_EM_RESTART': '1', 10:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:07 INFO - 'PWD': '/builds/slave/test', 10:09:07 INFO - 'SHELL': '/bin/bash', 10:09:07 INFO - 'SHLVL': '1', 10:09:07 INFO - 'TERM': 'linux', 10:09:07 INFO - 'TMOUT': '86400', 10:09:07 INFO - 'USER': 'cltbld', 10:09:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:07 INFO - '_': '/tools/buildbot/bin/python'} 10:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:07 INFO - Downloading/unpacking jsonschema 10:09:07 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:09:07 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:09:07 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:09:07 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:09:07 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:09:07 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:09:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:09 INFO - Downloading/unpacking functools32 (from jsonschema) 10:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:10 INFO - warning: no files found matching '*.txt' 10:09:10 INFO - no previously-included directories found matching 'build' 10:09:10 INFO - no previously-included directories found matching 'dist' 10:09:10 INFO - no previously-included directories found matching '.git*' 10:09:10 INFO - Installing collected packages: jsonschema, functools32 10:09:10 INFO - Running setup.py install for functools32 10:09:10 INFO - warning: no files found matching '*.txt' 10:09:10 INFO - no previously-included directories found matching 'build' 10:09:10 INFO - no previously-included directories found matching 'dist' 10:09:10 INFO - no previously-included directories found matching '.git*' 10:09:10 INFO - Successfully installed jsonschema functools32 10:09:10 INFO - Cleaning up... 10:09:10 INFO - Return code: 0 10:09:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f641d8d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, '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': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', '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:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:09:10 INFO - Using env: {'DISPLAY': ':0', 10:09:10 INFO - 'HOME': '/home/cltbld', 10:09:10 INFO - 'LANG': 'en_US.UTF-8', 10:09:10 INFO - 'LANGUAGE': 'en_US:en', 10:09:10 INFO - 'LOGNAME': 'cltbld', 10:09:10 INFO - 'MAIL': '/var/mail/cltbld', 10:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:10 INFO - 'MOZ_NO_REMOTE': '1', 10:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:10 INFO - 'NO_EM_RESTART': '1', 10:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:10 INFO - 'PWD': '/builds/slave/test', 10:09:10 INFO - 'SHELL': '/bin/bash', 10:09:10 INFO - 'SHLVL': '1', 10:09:10 INFO - 'TERM': 'linux', 10:09:10 INFO - 'TMOUT': '86400', 10:09:10 INFO - 'USER': 'cltbld', 10:09:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:10 INFO - '_': '/tools/buildbot/bin/python'} 10:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:10 INFO - Downloading/unpacking flake8 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:09:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:09:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:13 INFO - no previously-included directories found matching 'docs/_build' 10:09:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:09:13 INFO - Running setup.py install for pep8 10:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:13 INFO - no previously-included directories found matching 'docs/_build' 10:09:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:09:13 INFO - Cleaning up... 10:09:13 INFO - Return code: 0 10:09:13 INFO - Running post-action listener: _resource_record_post_action 10:09:13 INFO - Running post-action listener: _start_resource_monitoring 10:09:13 INFO - Starting resource monitoring. 10:09:13 INFO - ##### 10:09:13 INFO - ##### Running install step. 10:09:13 INFO - ##### 10:09:13 INFO - Running pre-action listener: _resource_record_pre_action 10:09:13 INFO - Running main action method: install 10:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:13 INFO - Reading from file tmpfile_stdout 10:09:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:13 INFO - Reading from file tmpfile_stdout 10:09:13 INFO - Output received: 10:09:13 INFO - Usage: mozinstall [options] installer 10:09:13 INFO - Options: 10:09:13 INFO - -h, --help show this help message and exit 10:09:13 INFO - -d DEST, --destination=DEST 10:09:13 INFO - Directory to install application into. [default: 10:09:13 INFO - "/builds/slave/test"] 10:09:13 INFO - --app=APP Application being installed. [default: firefox] 10:09:13 INFO - mkdir: /builds/slave/test/build/application 10:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:09:29 INFO - Reading from file tmpfile_stdout 10:09:29 INFO - Output received: 10:09:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:09:29 INFO - Running post-action listener: _resource_record_post_action 10:09:29 INFO - ##### 10:09:29 INFO - ##### Running run-tests step. 10:09:29 INFO - ##### 10:09:29 INFO - Running pre-action listener: _resource_record_pre_action 10:09:29 INFO - Running main action method: run_tests 10:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:29 INFO - Python 2.7.3 10:09:29 INFO - Return code: 0 10:09:29 INFO - grabbing minidump binary from tooltool 10:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2423410>, '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 0x2424310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24247a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:09:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:09:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:29 INFO - Return code: 0 10:09:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:09:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:09:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:09:30 INFO - Return code: 0 10:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:09:30 INFO - Using env: {'DISPLAY': ':0', 10:09:30 INFO - 'HOME': '/home/cltbld', 10:09:30 INFO - 'LANG': 'en_US.UTF-8', 10:09:30 INFO - 'LANGUAGE': 'en_US:en', 10:09:30 INFO - 'LOGNAME': 'cltbld', 10:09:30 INFO - 'MAIL': '/var/mail/cltbld', 10:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:30 INFO - 'MOZ_NO_REMOTE': '1', 10:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:30 INFO - 'NO_EM_RESTART': '1', 10:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:30 INFO - 'PWD': '/builds/slave/test', 10:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:30 INFO - 'SHELL': '/bin/bash', 10:09:30 INFO - 'SHLVL': '1', 10:09:30 INFO - 'TERM': 'linux', 10:09:30 INFO - 'TMOUT': '86400', 10:09:30 INFO - 'USER': 'cltbld', 10:09:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464196115.372422-1300823126', 10:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:30 INFO - '_': '/tools/buildbot/bin/python'} 10:09:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:09:30 INFO - mozversion application_buildid: 20160525073114 10:09:30 INFO - mozversion application_changeset: f887875e60c8738740089de8e85d6b68475de96e 10:09:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:09:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:30 INFO - mozversion application_name: Firefox 10:09:30 INFO - mozversion application_remotingname: firefox-dev 10:09:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:09:30 INFO - mozversion application_vendor: Mozilla 10:09:30 INFO - mozversion application_version: 48.0a2 10:09:30 INFO - mozversion platform_buildid: 20160525073114 10:09:30 INFO - mozversion platform_changeset: f887875e60c8738740089de8e85d6b68475de96e 10:09:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:09:30 INFO - mozversion platform_version: 48.0a2 10:09:30 INFO - using testdate: 1464196170 10:09:30 INFO - actual date: 1464196170 10:09:30 INFO - starting webserver on 'localhost:39826' 10:09:30 INFO - SUITE-START | Running 2 tests 10:09:30 INFO - TEST-START | dromaeo_css 10:09:30 INFO - operating with platform_type : linux_ 10:09:30 INFO - Initialising browser for dromaeo_css test... 10:09:30 INFO - TEST-INFO | started process 6269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppMeQIC/profile http://localhost:39826/getInfo.html) 10:09:34 INFO - PROCESS | 6269 | 10:09:34 INFO - PROCESS | 6269 | (process:6346): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:35 INFO - PROCESS | 6269 | __metrics Screen width/height:1600/1200 10:09:35 INFO - PROCESS | 6269 | colorDepth:24 10:09:35 INFO - PROCESS | 6269 | Browser inner width/height: 1024/697 10:09:35 INFO - PROCESS | 6269 | __metrics 10:09:35 ERROR - PROCESS | 6269 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:09:36 INFO - TEST-INFO | 6269: exit 0 10:09:36 INFO - Browser initialized. 10:09:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:36 INFO - TEST-INFO | started process 6397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppMeQIC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:38 INFO - PROCESS | 6397 | 10:09:38 INFO - PROCESS | 6397 | (process:6464): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:48 INFO - PROCESS | 6397 | RSS: Main: 151691264 10:09:48 INFO - PROCESS | 6397 | 10:10:38 INFO - PROCESS | 6397 | 1464196238016 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:12:45 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:39826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39826/tests/dromaeo/cssquery-ext.html) 10:12:46 INFO - PROCESS | 6397 | RSS: Main: 155500544 10:12:46 INFO - PROCESS | 6397 | 10:15:48 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:39826/tests/dromaeo/cssquery-ext.html (next: http://localhost:39826/tests/dromaeo/cssquery-jquery.html) 10:15:48 INFO - PROCESS | 6397 | RSS: Main: 153493504 10:15:48 INFO - PROCESS | 6397 | 10:18:50 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:39826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39826/tests/dromaeo/cssquery-mootools.html) 10:18:51 INFO - PROCESS | 6397 | RSS: Main: 153632768 10:18:51 INFO - PROCESS | 6397 | 10:21:52 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:39826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39826/tests/dromaeo/cssquery-prototype.html) 10:21:53 INFO - PROCESS | 6397 | RSS: Main: 152850432 10:21:53 INFO - PROCESS | 6397 | 10:24:55 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:39826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39826/tests/dromaeo/cssquery-yui.html) 10:24:56 INFO - PROCESS | 6397 | RSS: Main: 154533888 10:24:56 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | Cycle 1(1): loaded http://localhost:39826/tests/dromaeo/cssquery-yui.html (next: http://localhost:39826/tests/dromaeo/cssquery-dojo.html) 10:27:58 INFO - PROCESS | 6397 | RSS: Main: 156327936 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | __start_tp_report 10:27:58 INFO - PROCESS | 6397 | _x_x_mozilla_page_load 10:27:58 INFO - PROCESS | 6397 | _x_x_mozilla_page_load_details 10:27:58 INFO - PROCESS | 6397 | |i|pagename|runs| 10:27:58 INFO - PROCESS | 6397 | |0;dojo.html;3324.318514704486;3377.1725927147854;3395.5925288965327;3400.9829950850244;3414.8121853298076;5603.159526071091;5615.775368985241;5627.352854421748;5628.831135065944;5634;5562.443755624446;5582.91625625615;5623.325200975878;5626.746796394162;5635.3801081881065;5056.292119103319;5099.490050994889;5159.22611608258;5165.845024649267;5171.689698618095;4995.600351971833;5167.896642067157;5237.292965449654;5237.607179461536;5260.842174734745;5114.130597798383;5126.384833819947;5129.333186685725;5148.124818780816;5185.196294574328;5063.392392912837;5071.771770270347;5077.695338279678;5087.923681144785;5120;4909;5000.449950505442;5012.899742005139;5027.195648696227;5035.244713292998;5362.168863826113;5370.570354371641;5420.186971954238;5421.159720243369;5442;5797.942020579782;5921.289445266596;5924;5926.288845338587;5928.436798504178;5767.913481297784;5951.49412299955;5952.7321270542925;5953.940460595382;5956.702164891738;5526.143447765603;5561.388247292794;5563.888722225533;5595.860103497404;5645.971770141123;5967.075103358986;5983.401659833982;5985.401459854067;5987.191729116514;5989.8203053908455;5765.682887441147;5784;5796.855078623068;5849.356570777211;5866.6480011199465;5853.765849366063;5886.323072846678;5890.823275301748;5905.911411328833;5930.584859059824;5838.941610583925;5849.941500585025;5851.268591426072;5862.472377486047;5867.471927526458;5810.82567522975;5816.41835816415;5881.2942446906645;5883.470487656132;5895.67573783446;4532.9320060199125;4559.6808223424705;4561.817527298937;4563.840265590755;4581.381513495702;4093.6111069448357;4114.074333275049;4128.318827393447;4139.482564679415;4159.480064991876;5776.364599894008;5801.8549536261935;5807.245058142499;5817.88364232713;5842.766289348463;5883.794067207627;5971.880562388728;5997.940020599825;6008.4592386684535;6052.485538729257;5672.290963629546;5720.11338242573;5733.31200255972;5746.109353050284;5746.9712651436475;5113.181890897438;5136.383633963948;5175.689458632419;5188.481151884856;5210.583153347723;6178.5366097542865;6183.628982261079;6196.225471816023;6207.906881396782;6219.253689557282;5910.408959104056;5963.970180149072;5992.101184822224;6011;6018.398160183947;6122.764110201706;6162.691865406622;6175.783847565313;6186.257649081959;6200.875982480416;5891.558133139946;5896.911546326723;5898.882022359615;5923.229980102559;5935.317438494456;5919.141724450017;5925.4370834770625;5927.644341339534;5998.160257563857;6023.6385816851125;5792.82621521355;5794.0439827428;5804.82585522435;5808.07070868659;5822.592418530831;5717.971410142923;5756.971215143897;5757.8560535986935;5758.71206439668;5778.971105144447;5581.358143813351;5660.6037577370835;5698.8290351289525;5703.287089113861;5760.1935728998815;5864.912026319694;5892.646441213541;5895.616784908967;5898.616589921641;5930.28836539618;5669.574781891292;5754.194412782297;5759.337676167127;5767.106098554731;5771.509421699203 10:27:58 INFO - PROCESS | 6397 | |1;ext.html;618.8112625649176;652.5693042591889;661.8246164766338;677.8068250548595;684.3020119478135;39291.21417571647;40588.188236235255;40725.59274407255;40892.18215635685;41008.179836403295;42963.57036429643;43151.13697726044;43370;43475.34786978198;43530.129397412034;8703.521306328134;8933.821323573524;8941.150590693873;8946.329025323093;8969.058248883839;8769.342299327576;8927.285817134614;8934.374593778439;9147.908520914772;9152.039035901234;9149.63401463944;9224.308176886727;9286.814263714721;9308.115729005734;9309.953450232739;9197.632094716204;9203.309751768611;9238.491882946435;9240.214581760558;9272.72181834546;9036.322275829274;9116.8632470513;9159.954200229024;9162.86255706165;9190.908090919072;42732.145357092995;43052.56947430517;43170.56829431697;43363.78318108421;43427.34858977118;3760.567534733513;4039.515258169009;4235.788210589458;4250.4899412070445;4621;32257.6774232257;32452.675473245203;33075.83462082698;34256.82871585651;34678.9596312111;4635.096156249533;4699.201135806921;4706.22347312693;4712.5051869553545;4741.051789642085;298624.99999999785;298848;299079;300315;300561;39644.40533392001;62545.37454625487;62669.37330626635;62707;62804.685976569825;38120.61879381226;38138.80930595329;38179.80910095432;38238.6176138235;38276.80861595674;16701.24844382006;16931.661366772594;16946.40687575929;16967.575810604587;16969.490915272563;13423.932880335537;13432.059755817;13471.259080750653;13481.730365392834;13588.864111358958;9294.302927280482;9461.290403219786;9465.621375145054;9489.145976862115;9564.187044101329;3620.2216523447587;3679.282539904693;3680.5583330000572;3686.5207523021836;3763.9059023524082;1093.103655002906;1094.2723089145788;1186.1341220908785;1208.746163305698;1227.2697744841805;33646.32707345839;33747.49378759321;33842.830785845916;33862.32275354528;34002.14994625105;1157.1841851494676;1211.7515909238762;1217.6712287682276;1233.6998528935062;1275.4630670042577;15028.849711502746;15772.605684857741;16074.010403986686;16097.114658693885;16222.675546489005;524652;537779;537799;555956;881505;58439.70780146072;59579.404205957384;59745;59760.40239597635;59807.40192598105;1588.602849287678;1589.2927647196886;1601.3354457900075;1610.9355625774838;1620.1656147084261;31048.68951310458;31699.31867528495;31834.52248216325;31913.521297180097;32599;55625.721871392;56144.438555613924;56379.436205637416;56385;56499.30502084944;332535;338353;338806;339163;339316;46547.76726116348;46644;46935.765321173174;47152.7642361786;48078.27882581694;50500.74749626228;51257.743711281204;51676.483235167165;52142.739286303324;52245;42486;42554.361684574134;42601.573984261;43225;43978.34032489451;41560.79219603883;41755;42442;42998.71003869889;43519;43507.78246108749;43641.34537981996;44298.3355249678;44510.9970051342;44545;36480.635193648784;37187.42705596587;37904.24191516209;38154;38627.2274554513;29394;29464;29757.70242297636;29914.551281731226;29934.25164370908 10:27:58 INFO - PROCESS | 6397 | |2;jquery.html;424.75788800383793;431.8769150792024;434.1277575972356;437.40949717880864;437.95839395257457;18451.07744612769;19191.520211994706;19234.23063077477;19321.13054912529;20227.292044778435;12716.809247861289;12989.870101298984;15082.622934426645;20156.899215503938;20249.291274805386;5328.413874473805;5573.665580065189;5578.163275508686;5579.972100139494;5643.548516118721;5864.882702345951;6963.442924566048;7269.781906542812;7292.41660667148;7302;7102.538335008208;7231.602261875595;7707.113681926566;7707.30634242918;7712.5372477651235;6885.552439091443;7495.400367970549;7515.699372025139;7580.393568514533;7598.772036838904;6915.89626155608;6963.338482844172;7008.123984501937;7013.649317534154;7029.29707029293;25318.49363012748;26015.479690406275;26151;26629.334266643487;27557.724422755717;2718.4834881372476;2733.3576609496754;2794.3572978215125;2832.1928250448727;3104.2239440139965;15374.692506149815;15992.280347384396;16528.75206871898;16728.83271167297;16751.748723769033;2222.7999480046874;2226.922057727988;2270.2735124760084;2313.144136669426;2366.467544802406;90250;90274.5486272571;91014;92294.53852730761;94002.52998735031;18955.526111847314;19286.132124054453;19652.50868728293;19970.90014549918;20033.79966200319;34484;34547;34660.747051441576;35313.64686353155;35457.64542354595;7940.880886786703;8182.631781569844;8341.45780524276;8348.791280217922;8403.36974726898;8067.233612806774;8263.834723305501;8264.090949995496;8264.83470330602;8299.087100418948;3834.69322454203;4042.939355909664;4076.245894509466;4606.124836281096;4629.629629629621;1895.6587814193579;1966.8229859312444;1968.9901550492157;1987.0561483295608;1989.4827344890432;1066.7439814444479;1078.1536493852288;1086.5436516663021;1186.454231053725;1186.6321440353345;18769.249230030648;18848.340308089424;19059.61880762377;19243.422697319103;19561.902190488956;1046.2676126711333;1110.1230028277732;1127.3461392392392;1145.095374654014;1166.7141550320225;10595.629152979609;10769.9461502692;10891.237613367146;10926.617568385069;11054.115670746321;519698;522148;524542;526925;535838;92577.537112314;92887;93533.53233233927;93697;93733.5313323429;1127.689885281554;1130.2822707580744;1149.7872893514727;1154.9018333441584;1155.3183621663259;16768.916155419145;16776;16784.752516570326;17110;17140.314387424864;27473.17580472589;33306.33387332191;38505.807470963584;39159.02102447348;39531.40702889401;54812;56799.71600141973;56805.43194568167;57183.142252867074;57747.13379299398;8698.956505217433;8836.204741573289;8949.105089490999;9026.142516460926;9134.086591340812;13151.473941042252;13158.078934474877;13224.537141200011;13293.20240785556;13333.266670333225;11853.703657408634;11919.404029798648;12018.038556915251;12062.276263424223;12184.634460966185;11712.590059347882;11775.843427221915;11877.940610297239;12338.691532711755;12358.876411235773;11934;12045.63863084109;12172.45223964906;12244.693882653006;12291.139620226499;8666.696665616673;8691.91308086911;8944.105589441004;9020.233280171258;9138.634454622006;11769.411529423665;11791.705207369541;11837.940810295893;11842.348670823187;11972.700682482659 10:27:58 INFO - PROCESS | 6397 | |3;mootools.html;1529.6175956010998;1552.076514473888;1768.3633891798959;1845.3264558436174;1873.6533741257867;7383.335499805016;8265.586720663965;8266.090730019692;8420.031696354921;8469.491830490175;8146.91853081469;8331.500109993389;8339.082700902896;8340.541270230135;8368.707095251668;2364.929052128439;2402.411409204747;2402.7236867760257;2418.842775219614;2424.8181386396004;2306.08909480755;2326.5928462519078;2329.801966832821;2346.120204923154;2364.43253619131;2396.9640455393182;2417.3593997590565;2418.3833122553724;2430.0279888044834;2437.597796363598;2392.3540644026016;2411.915582954597;2423.3941514621347;2424.187897054489;2425.7938075263623;2297.1270917051415;2357;2358.646203069536;2368.5026144509675;2373.8575685458927;8402.327813774884;8436;8460.36547258952;8476.110008449148;8509.361797865186;5321.920171197435;5433.293671822677;5438.755256013489;5448.346198456211;5448.673079615196;3467.1450773835877;3525.964740352589;3595.209054008114;3596.4245720684826;3632.8728494502566;1121.1871393239917;1129.7232178116415;1139.549877798265;1166.1836714300025;1168.0480408467072;11964;11974.22167559106;12086.033117350591;12121.757564848742;12152;4775.61889732718;4807.927881081787;4814.614830813526;4914.778834952435;4921.212605983097;10136.44249566281;10246.53890574926;10249.590016399261;10252.487375631337;10281.126104281071;5309.65487243328;5393.110136827379;5396.514313711785;5399.325084364455;5408.783648654088;4364.803583838735;4644.558766917137;4718.079974404958;4738.549837765407;4945.406551213878;4092.6725861930972;4154.543000269968;4170.812313445902;4177;4353.891152721144;1364.283751030697;1380.7307575022976;1395.239594421043;1397.82527184102;1398.210011343608;971.8347880860271;1021.8810402609131;1057.0856209378833;1067.4555976451911;1076.1175835814713;5660.632058916157;5732.082866741302;5772.5959182856795;5872.324682661463;5947;1019.2966852871494;1058.5977328615077;1097.2977294531506;1107.6234080412698;1109.9389533575732;4010.8195131219163;4062.4921884764403;4067.5322337930925;4088.713790034669;4091.734037287567;10560.683179504627;10652.520636571373;10716.571337146426;10743.78512429747;10764.192685548614;10434.16526677864;10530.420826854597;10584.682459526226;10600.098991585648;10600.946995264974;8114.63484143215;8159.347252219808;8262.462939908886;8274.420790544724;8275.379346549033;5704.914426283526;5770.365259821332;5802.47777700009;5875.911861321998;5907.586468947133;9196.172344489029;9206.677766278148;9288.210502107397;9348.971613122687;9428.340016198801;9250.676226332045;9474.24206063527;9491.477968711511;9545.28410369239;9603.615855365708;6618.106555614931;7046.718131274896;7270.600116993616;7336.082989626297;7435.442341824277;8167.836643266983;8193.50838949665;8202.548859812767;8215.794605134919;8255.215754503313;7134.1795693495915;7290.817729556804;7323.121225452766;7334.816629584089;7499.62501874915;7105.18290396611;7114.964425177841;7129.21578626361;7133.179684336368;7431.628418579157;6359.459445947146;6389.265234497906;6389.616623002449;6402.103705481143;6415.8716825662295;4787.640926930424;4914.1154592172325;4921.803127874845;4956.355673762388;4975.4278258000795;5162.741862906914;5217.791288348423;5223.3209682741;5261.210818377274;5292.894142117213 10:27:58 INFO - PROCESS | 6397 | |4;prototype.html;361.808241631935;362.7696412777886;363.76355369010156;365.63984475291835;368.2726614935503;6659;6690.029945657883;6723.327667233274;6750.594964302145;6765.864682706343;6614.272430032693;6617.33826617338;6621.205455345354;6625;6631.27056023837;4756.66703330767;4853.466118726938;5008.323876276692;5008.974955125237;5030.06943715412;4981.72600506972;5005.324281222025;5007.799688012475;5013.273075404064;5015.84952451427;4954.331165292675;4956.107900577895;4986.927810520738;4988.650794444372;4988.950110498885;4979.7261150636705;4989.476105008958;4995.250712393152;5001.374828146481;5003.649744517885;4367.781610919441;4376.059147283349;4376.299792033259;4384.057427653038;4387.3857659927635;6124.448799608057;6300.905486417708;6361.2048493938255;6366;6399.424051835357;5698.857528561819;5714.79998200061;5723.826615543803;5779.797707080274;5789.623674461147;7001.264867188923;7005.754798582026;7011.719531218745;7013.298670132997;7014.894776578355;4784.425868895755;4788.664793464459;4794.688345257547;4798.088363210979;4801.327814106028;7179.605121718356;7219.530730502501;7290.161631412402;7295.306945840137;7300.780976570712;4877.878053048631;4881.560659540658;4895.902081958341;4901.877453063702;4903.141950158708;4915.090708218991;4931.901361972812;4932.679375840559;4947.6536642434685;4964.05682920244;5740.971295143498;5755.0791873300905;5772.365039845614;5773.88452230953;5775.191473193756;6985.860282794316;7000.824979375557;7021.684024218923;7040.964795175992;7049.154101507749;1734;1765.823417658224;1768.5224989253088;1773.122304459301;1773.973390399145;1114.0975809594254;1132.2074547816562;1134.7106487845713;1141.5034460009756;1149.3046706742468;6626.138601981712;6626.83432914181;6765.9661701691175;6817.318268173143;6819.283975182633;7129.108861392326;7173.569585824867;7188.784336469915;7214.386777124003;7244.420446364278;6835.111435513351;6886.621235831977;6901.930980690229;6902.585844849325;6905.75829845953;3911.2177564487215;3935.74417662851;3958.7228893977144;3960.2475529649273;3969.0871099647243;7588.241175882367;7632.274933881273;7654.693812247559;7668.271514206142;7676.462647614613;7356.485046046725;7503.137139229058;7509.3617042552;7533.472656914073;7567.962160189274;7631.122420921554;7688.154303026663;7698;7726.6136693166245;7772;7344.449166312441;7358.411327093927;7362.5214361066355;7364.815879603053;7370.299821516947;7332.816679583053;7334.926650733638;7337.229590893093;7341.229170936975;7370.336669699753;7472.252774722484;7674.961625192062;7681.884771728317;7698;7705.499142555716;5057.165567681292;5071.315372424823;5093.541581257705;5096.23556466533;5105.183170692671;7182.317679820409;7224.711011559689;7244.203137654959;7259.854802903807;7261.455390845602;7011.404030657452;7033.613151276524;7036.612986285803;7071.469639776935;7088;6831.453483721191;6989.510734248757;7065.364117229474;7079.964600176966;7095.787126386217;6930.237673855972;6943.861122777617;6948.652567371712;6981.895271570829;6995.860082798417;7095.716171353294;7109.040279562193;7135.785926422215;7147.678354474165;7157;6783.559068660521;6872.965635171792;6937.410320122644;6980.546264492792;6981.02265682815 10:27:58 INFO - PROCESS | 6397 | |5;yui.html;835.653203920373;851.940364174508;878.3079860228396;895.4671970177742;897.6364572348198;14247.501337453179;14529.636759081028;14742.63143421415;14746.262686865668;14746.778798318033;13401.92784577234;13434.731305373887;13544.593662190126;13551.59345219645;13559.457621695145;754.9320561149495;892.1479986612769;899.883015208022;906.759708677201;914.9542522873863;898.1961144775422;898.3217670658644;906.5784410249232;907.419251678926;908.6865031564133;950.6054987180312;955.3599088610613;957.5116690487831;957.6887511558771;961.1157734883889;954.3796532254021;955.4458414119794;956.273232343417;956.3974695941582;958.228625956105;690.2234985641154;692.3076923076923;693.7918624412706;700.9018737376771;704.6899364279752;14977.700445991019;15075.47235846751;15094.471693490676;15113.093214407061;15197.772033419507;14578;14778;14813.481528146463;14907;14930.47743328989;11369.374684392355;11557.711057223552;11687.883121168765;11811.94094029533;11915.523379064827;3922.333203355408;3960.1683646434285;4059.6955228357992;4145.937810932838;4155.439015732898;54123;54173.45826541723;55268.44731552713;56845.14732279019;57068.143977840366;11225.382603956697;11359.716007099889;11374.090072794157;11391.886081139248;11545.249558778652;20093.09581068826;20159.899200503904;20186.39440816778;20234.291799786937;20469.795302047085;8878;9010.63957441708;9038.09619038104;9117.680881169128;9147.771305717277;4900.485449027872;4904.239842824368;4912.410510738734;4914.778834952435;4935.087008903364;3416.2825806580895;3509.298140371885;3523.436250199956;3524.1718196223865;3531.6821486065865;633.5375176121457;641.8074577626693;642.0465608571268;643.7457204404234;656.8981807819796;602.5149754447624;727.3526561360394;752.2289653105502;753.5516367761173;756.481809960179;9186.26509879208;9255.861162082574;9318.72043838686;9326;9385.15533601979;664.2095905871997;703.2088899987514;767.4512723402794;773.7949443397504;778.2528772378466;4248.086661367759;4257.574242575718;4263.253930562201;4268.743875367488;4378.233809083461;63057.68471157615;63062.36937630565;64495;65050.67474662596;65209.347906521274;56958.14562781562;57044.144337834965;57659.42340576625;58507.41492585105;59342.703286483295;50907;51627;51694.483055169716;51805.74097129566;52245.2163217552;8424.199701028392;8533.786655333666;8576.356773241907;8578.18507241811;8774.034856165945;38315.808420957714;38849;38861;38937.6106238934;39520.60479395284;45150.54849451595;45551.772241138584;47674.76162619165;49286.75356623194;50135;11498.137639677225;11647.941760291144;12762.553310634083;13074.869251307746;13077.869221307665;13663.453461861813;13803.17180969145;13830.930845345709;13903.721925561635;14333.64165895861;12154.878451215374;12755.362231888554;12973.54592589255;13080.542181023618;13205.471781128646;13237.669058273621;13432.307883920786;13467.595972120853;13492.460301587827;13519.864801352254;12555.183913045623;12580.433880475217;12729;12782.936085319514;13274.203547787163;10331.173506119643;10668.199885008811;10833.29583577065;11243.269187502787;11267.718307042389;10539.367637941748;10632.202584806017;10692.786144277226;10762.139028877828;10885.183611229348 10:27:58 INFO - PROCESS | 6397 | __end_tp_report 10:27:58 INFO - PROCESS | 6397 | __start_cc_report 10:27:58 INFO - PROCESS | 6397 | _x_x_mozilla_cycle_collect,330 10:27:58 INFO - PROCESS | 6397 | __end_cc_report 10:27:58 INFO - PROCESS | 6397 | __startTimestamp1464197278810__endTimestamp 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | ------- Summary: start ------- 10:27:58 INFO - PROCESS | 6397 | Number of tests: 6 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | [#0] dojo.html Cycles:165 Average:5539.47 Median:5765.68 stddev:594.59 (10.3%) stddev-sans-first:570.46 10:27:58 INFO - PROCESS | 6397 | Values: 3324.3 3377.2 3395.6 3401.0 3414.8 5603.2 5615.8 5627.4 5628.8 5634.0 5562.4 5582.9 5623.3 5626.7 5635.4 5056.3 5099.5 5159.2 5165.8 5171.7 4995.6 5167.9 5237.3 5237.6 5260.8 5114.1 5126.4 5129.3 5148.1 5185.2 5063.4 5071.8 5077.7 5087.9 5120.0 4909.0 5000.4 5012.9 5027.2 5035.2 5362.2 5370.6 5420.2 5421.2 5442.0 5797.9 5921.3 5924.0 5926.3 5928.4 5767.9 5951.5 5952.7 5953.9 5956.7 5526.1 5561.4 5563.9 5595.9 5646.0 5967.1 5983.4 5985.4 5987.2 5989.8 5765.7 5784.0 5796.9 5849.4 5866.6 5853.8 5886.3 5890.8 5905.9 5930.6 5838.9 5849.9 5851.3 5862.5 5867.5 5810.8 5816.4 5881.3 5883.5 5895.7 4532.9 4559.7 4561.8 4563.8 4581.4 4093.6 4114.1 4128.3 4139.5 4159.5 5776.4 5801.9 5807.2 5817.9 5842.8 5883.8 5971.9 5997.9 6008.5 6052.5 5672.3 5720.1 5733.3 5746.1 5747.0 5113.2 5136.4 5175.7 5188.5 5210.6 6178.5 6183.6 6196.2 6207.9 6219.3 5910.4 5964.0 5992.1 6011.0 6018.4 6122.8 6162.7 6175.8 6186.3 6200.9 5891.6 5896.9 5898.9 5923.2 5935.3 5919.1 5925.4 5927.6 5998.2 6023.6 5792.8 5794.0 5804.8 5808.1 5822.6 5718.0 5757.0 5757.9 5758.7 5779.0 5581.4 5660.6 5698.8 5703.3 5760.2 5864.9 5892.6 5895.6 5898.6 5930.3 5669.6 5754.2 5759.3 5767.1 5771.5 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | [#1] ext.html Cycles:180 Average:58234.54 Median:42666.86 stddev:118638.49 (278.1%) stddev-sans-first:118892.43 10:27:58 INFO - PROCESS | 6397 | Values: 618.8 652.6 661.8 677.8 684.3 39291.2 40588.2 40725.6 40892.2 41008.2 42963.6 43151.1 43370.0 43475.3 43530.1 8703.5 8933.8 8941.2 8946.3 8969.1 8769.3 8927.3 8934.4 9147.9 9152.0 9149.6 9224.3 9286.8 9308.1 9310.0 9197.6 9203.3 9238.5 9240.2 9272.7 9036.3 9116.9 9160.0 9162.9 9190.9 42732.1 43052.6 43170.6 43363.8 43427.3 3760.6 4039.5 4235.8 4250.5 4621.0 32257.7 32452.7 33075.8 34256.8 34679.0 4635.1 4699.2 4706.2 4712.5 4741.1 298625.0 298848.0 299079.0 300315.0 300561.0 39644.4 62545.4 62669.4 62707.0 62804.7 38120.6 38138.8 38179.8 38238.6 38276.8 16701.2 16931.7 16946.4 16967.6 16969.5 13423.9 13432.1 13471.3 13481.7 13588.9 9294.3 9461.3 9465.6 9489.1 9564.2 3620.2 3679.3 3680.6 3686.5 3763.9 1093.1 1094.3 1186.1 1208.7 1227.3 33646.3 33747.5 33842.8 33862.3 34002.1 1157.2 1211.8 1217.7 1233.7 1275.5 15028.8 15772.6 16074.0 16097.1 16222.7 524652.0 537779.0 537799.0 555956.0 881505.0 58439.7 59579.4 59745.0 59760.4 59807.4 1588.6 1589.3 1601.3 1610.9 1620.2 31048.7 31699.3 31834.5 31913.5 32599.0 55625.7 56144.4 56379.4 56385.0 56499.3 332535.0 338353.0 338806.0 339163.0 339316.0 46547.8 46644.0 46935.8 47152.8 48078.3 50500.7 51257.7 51676.5 52142.7 52245.0 42486.0 42554.4 42601.6 43225.0 43978.3 41560.8 41755.0 42442.0 42998.7 43519.0 43507.8 43641.3 44298.3 44511.0 44545.0 36480.6 37187.4 37904.2 38154.0 38627.2 29394.0 29464.0 29757.7 29914.6 29934.3 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | [#2] jquery.html Cycles:180 Average:31318.02 Median:15103.27 stddev:86539.49 (573.0%) stddev-sans-first:86751.17 10:27:58 INFO - PROCESS | 6397 | Values: 424.8 431.9 434.1 437.4 438.0 18451.1 19191.5 19234.2 19321.1 20227.3 12716.8 12989.9 15082.6 20156.9 20249.3 5328.4 5573.7 5578.2 5580.0 5643.5 5864.9 6963.4 7269.8 7292.4 7302.0 7102.5 7231.6 7707.1 7707.3 7712.5 6885.6 7495.4 7515.7 7580.4 7598.8 6915.9 6963.3 7008.1 7013.6 7029.3 25318.5 26015.5 26151.0 26629.3 27557.7 2718.5 2733.4 2794.4 2832.2 3104.2 15374.7 15992.3 16528.8 16728.8 16751.7 2222.8 2226.9 2270.3 2313.1 2366.5 90250.0 90274.5 91014.0 92294.5 94002.5 18955.5 19286.1 19652.5 19970.9 20033.8 34484.0 34547.0 34660.7 35313.6 35457.6 7940.9 8182.6 8341.5 8348.8 8403.4 8067.2 8263.8 8264.1 8264.8 8299.1 3834.7 4042.9 4076.2 4606.1 4629.6 1895.7 1966.8 1969.0 1987.1 1989.5 1066.7 1078.2 1086.5 1186.5 1186.6 18769.2 18848.3 19059.6 19243.4 19561.9 1046.3 1110.1 1127.3 1145.1 1166.7 10595.6 10769.9 10891.2 10926.6 11054.1 519698.0 522148.0 524542.0 526925.0 535838.0 92577.5 92887.0 93533.5 93697.0 93733.5 1127.7 1130.3 1149.8 1154.9 1155.3 16768.9 16776.0 16784.8 17110.0 17140.3 27473.2 33306.3 38505.8 39159.0 39531.4 54812.0 56799.7 56805.4 57183.1 57747.1 8699.0 8836.2 8949.1 9026.1 9134.1 13151.5 13158.1 13224.5 13293.2 13333.3 11853.7 11919.4 12018.0 12062.3 12184.6 11712.6 11775.8 11877.9 12338.7 12358.9 11934.0 12045.6 12172.5 12244.7 12291.1 8666.7 8691.9 8944.1 9020.2 9138.6 11769.4 11791.7 11837.9 11842.3 11972.7 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | [#3] mootools.html Cycles:180 Average:5662.84 Median:4811.27 stddev:3095.16 (64.3%) stddev-sans-first:3088.26 10:27:58 INFO - PROCESS | 6397 | Values: 1529.6 1552.1 1768.4 1845.3 1873.7 7383.3 8265.6 8266.1 8420.0 8469.5 8146.9 8331.5 8339.1 8340.5 8368.7 2364.9 2402.4 2402.7 2418.8 2424.8 2306.1 2326.6 2329.8 2346.1 2364.4 2397.0 2417.4 2418.4 2430.0 2437.6 2392.4 2411.9 2423.4 2424.2 2425.8 2297.1 2357.0 2358.6 2368.5 2373.9 8402.3 8436.0 8460.4 8476.1 8509.4 5321.9 5433.3 5438.8 5448.3 5448.7 3467.1 3526.0 3595.2 3596.4 3632.9 1121.2 1129.7 1139.5 1166.2 1168.0 11964.0 11974.2 12086.0 12121.8 12152.0 4775.6 4807.9 4814.6 4914.8 4921.2 10136.4 10246.5 10249.6 10252.5 10281.1 5309.7 5393.1 5396.5 5399.3 5408.8 4364.8 4644.6 4718.1 4738.5 4945.4 4092.7 4154.5 4170.8 4177.0 4353.9 1364.3 1380.7 1395.2 1397.8 1398.2 971.8 1021.9 1057.1 1067.5 1076.1 5660.6 5732.1 5772.6 5872.3 5947.0 1019.3 1058.6 1097.3 1107.6 1109.9 4010.8 4062.5 4067.5 4088.7 4091.7 10560.7 10652.5 10716.6 10743.8 10764.2 10434.2 10530.4 10584.7 10600.1 10600.9 8114.6 8159.3 8262.5 8274.4 8275.4 5704.9 5770.4 5802.5 5875.9 5907.6 9196.2 9206.7 9288.2 9349.0 9428.3 9250.7 9474.2 9491.5 9545.3 9603.6 6618.1 7046.7 7270.6 7336.1 7435.4 8167.8 8193.5 8202.5 8215.8 8255.2 7134.2 7290.8 7323.1 7334.8 7499.6 7105.2 7115.0 7129.2 7133.2 7431.6 6359.5 6389.3 6389.6 6402.1 6415.9 4787.6 4914.1 4921.8 4956.4 4975.4 5162.7 5217.8 5223.3 5261.2 5292.9 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | [#4] prototype.html Cycles:180 Average:5887.11 Median:6758.23 stddev:1808.27 (26.8%) stddev-sans-first:1765.14 10:27:58 INFO - PROCESS | 6397 | Values: 361.8 362.8 363.8 365.6 368.3 6659.0 6690.0 6723.3 6750.6 6765.9 6614.3 6617.3 6621.2 6625.0 6631.3 4756.7 4853.5 5008.3 5009.0 5030.1 4981.7 5005.3 5007.8 5013.3 5015.8 4954.3 4956.1 4986.9 4988.7 4989.0 4979.7 4989.5 4995.3 5001.4 5003.6 4367.8 4376.1 4376.3 4384.1 4387.4 6124.4 6300.9 6361.2 6366.0 6399.4 5698.9 5714.8 5723.8 5779.8 5789.6 7001.3 7005.8 7011.7 7013.3 7014.9 4784.4 4788.7 4794.7 4798.1 4801.3 7179.6 7219.5 7290.2 7295.3 7300.8 4877.9 4881.6 4895.9 4901.9 4903.1 4915.1 4931.9 4932.7 4947.7 4964.1 5741.0 5755.1 5772.4 5773.9 5775.2 6985.9 7000.8 7021.7 7041.0 7049.2 1734.0 1765.8 1768.5 1773.1 1774.0 1114.1 1132.2 1134.7 1141.5 1149.3 6626.1 6626.8 6766.0 6817.3 6819.3 7129.1 7173.6 7188.8 7214.4 7244.4 6835.1 6886.6 6901.9 6902.6 6905.8 3911.2 3935.7 3958.7 3960.2 3969.1 7588.2 7632.3 7654.7 7668.3 7676.5 7356.5 7503.1 7509.4 7533.5 7568.0 7631.1 7688.2 7698.0 7726.6 7772.0 7344.4 7358.4 7362.5 7364.8 7370.3 7332.8 7334.9 7337.2 7341.2 7370.3 7472.3 7675.0 7681.9 7698.0 7705.5 5057.2 5071.3 5093.5 5096.2 5105.2 7182.3 7224.7 7244.2 7259.9 7261.5 7011.4 7033.6 7036.6 7071.5 7088.0 6831.5 6989.5 7065.4 7080.0 7095.8 6930.2 6943.9 6948.7 6981.9 6995.9 7095.7 7109.0 7135.8 7147.7 7157.0 6783.6 6873.0 6937.4 6980.5 6981.0 10:27:58 INFO - PROCESS | 6397 | 10:27:58 INFO - PROCESS | 6397 | [#5] yui.html Cycles:180 Average:15414.13 Median:45351.16 stddev:17824.37 (39.3%) stddev-sans-first:17840.75 10:27:58 INFO - PROCESS | 6397 | Values: 835.7 851.9 878.3 895.5 897.6 14247.5 14529.6 14742.6 14746.3 14746.8 13401.9 13434.7 13544.6 13551.6 13559.5 754.9 892.1 899.9 906.8 915.0 898.2 898.3 906.6 907.4 908.7 950.6 955.4 957.5 957.7 961.1 954.4 955.4 956.3 956.4 958.2 690.2 692.3 693.8 700.9 704.7 14977.7 15075.5 15094.5 15113.1 15197.8 14578.0 14778.0 14813.5 14907.0 14930.5 11369.4 11557.7 11687.9 11811.9 11915.5 3922.3 3960.2 4059.7 4145.9 4155.4 54123.0 54173.5 55268.4 56845.1 57068.1 11225.4 11359.7 11374.1 11391.9 11545.2 20093.1 20159.9 20186.4 20234.3 20469.8 8878.0 9010.6 9038.1 9117.7 9147.8 4900.5 4904.2 4912.4 4914.8 4935.1 3416.3 3509.3 3523.4 3524.2 3531.7 633.5 641.8 642.0 643.7 656.9 602.5 727.4 752.2 753.6 756.5 9186.3 9255.9 9318.7 9326.0 9385.2 664.2 703.2 767.5 773.8 778.3 4248.1 4257.6 4263.3 4268.7 4378.2 63057.7 63062.4 64495.0 65050.7 65209.3 56958.1 57044.1 57659.4 58507.4 59342.7 50907.0 51627.0 51694.5 51805.7 52245.2 8424.2 8533.8 8576.4 8578.2 8774.0 38315.8 38849.0 38861.0 38937.6 39520.6 45150.5 45551.8 47674.8 49286.8 50135.0 11498.1 11647.9 12762.6 13074.9 13077.9 13663.5 13803.2 13830.9 13903.7 14333.6 12154.9 12755.4 12973.5 13080.5 13205.5 13237.7 13432.3 13467.6 13492.5 13519.9 12555.2 12580.4 12729.0 12782.9 13274.2 10331.2 10668.2 10833.3 11243.3 11267.7 10539.4 10632.2 10692.8 10762.1 10885.2 10:27:58 INFO - PROCESS | 6397 | -------- Summary: end -------- 10:27:58 INFO - PROCESS | 6397 | 10:27:59 INFO - TEST-INFO | 6397: exit 0 10:27:59 INFO - TEST-OK | dromaeo_css | took 1108967ms 10:27:59 INFO - TEST-START | kraken 10:27:59 INFO - operating with platform_type : linux_ 10:27:59 INFO - Initialising browser for kraken test... 10:27:59 INFO - TEST-INFO | started process 6642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ4ks37/profile http://localhost:39826/getInfo.html) 10:28:03 INFO - PROCESS | 6642 | 10:28:03 INFO - PROCESS | 6642 | (process:6719): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:04 INFO - PROCESS | 6642 | __metrics Screen width/height:1600/1200 10:28:04 INFO - PROCESS | 6642 | colorDepth:24 10:28:04 INFO - PROCESS | 6642 | Browser inner width/height: 1024/697 10:28:04 INFO - PROCESS | 6642 | __metrics 10:28:04 ERROR - PROCESS | 6642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:28:05 INFO - TEST-INFO | 6642: exit 0 10:28:05 INFO - Browser initialized. 10:28:05 INFO - Running cycle 1/1 for kraken test... 10:28:05 INFO - TEST-INFO | started process 6770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ4ks37/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:07 INFO - PROCESS | 6770 | 10:28:07 INFO - PROCESS | 6770 | (process:6842): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:17 INFO - PROCESS | 6770 | RSS: Main: 151945216 10:28:17 INFO - PROCESS | 6770 | 10:28:19 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39826/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:20 INFO - PROCESS | 6770 | RSS: Main: 156921856 10:28:20 INFO - PROCESS | 6770 | 10:28:23 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39826/tests/kraken/driver.html?testName=audio-dft) 10:28:23 INFO - PROCESS | 6770 | RSS: Main: 157401088 10:28:23 INFO - PROCESS | 6770 | 10:28:26 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39826/tests/kraken/driver.html?testName=audio-fft) 10:28:27 INFO - PROCESS | 6770 | RSS: Main: 157204480 10:28:27 INFO - PROCESS | 6770 | 10:28:29 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39826/tests/kraken/driver.html?testName=audio-oscillator) 10:28:30 INFO - PROCESS | 6770 | RSS: Main: 157126656 10:28:30 INFO - PROCESS | 6770 | 10:28:32 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:32 INFO - PROCESS | 6770 | RSS: Main: 157192192 10:28:32 INFO - PROCESS | 6770 | 10:28:35 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39826/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:36 INFO - PROCESS | 6770 | RSS: Main: 157396992 10:28:36 INFO - PROCESS | 6770 | 10:28:39 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39826/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:40 INFO - PROCESS | 6770 | RSS: Main: 157437952 10:28:40 INFO - PROCESS | 6770 | 10:28:43 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39826/tests/kraken/driver.html?testName=json-parse-financial) 10:28:43 INFO - PROCESS | 6770 | RSS: Main: 157630464 10:28:43 INFO - PROCESS | 6770 | 10:28:45 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:46 INFO - PROCESS | 6770 | RSS: Main: 157605888 10:28:46 INFO - PROCESS | 6770 | 10:28:47 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:48 INFO - PROCESS | 6770 | RSS: Main: 157655040 10:28:48 INFO - PROCESS | 6770 | 10:28:50 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:51 INFO - PROCESS | 6770 | RSS: Main: 157585408 10:28:51 INFO - PROCESS | 6770 | 10:28:53 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:54 INFO - PROCESS | 6770 | RSS: Main: 158023680 10:28:54 INFO - PROCESS | 6770 | 10:28:56 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:57 INFO - PROCESS | 6770 | RSS: Main: 157896704 10:28:57 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | Cycle 1(1): loaded http://localhost:39826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39826/tests/kraken/driver.html?testName=ai-astar) 10:28:59 INFO - PROCESS | 6770 | RSS: Main: 159363072 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | __start_tp_report 10:28:59 INFO - PROCESS | 6770 | _x_x_mozilla_page_load 10:28:59 INFO - PROCESS | 6770 | _x_x_mozilla_page_load_details 10:28:59 INFO - PROCESS | 6770 | |i|pagename|runs| 10:28:59 INFO - PROCESS | 6770 | |0;ai-astar;108;112;105;111;114;111;100;109;110;109 10:28:59 INFO - PROCESS | 6770 | |1;audio-beat-detection;163;132;152;170;133;163;159;128;181;128 10:28:59 INFO - PROCESS | 6770 | |2;audio-dft;163;163;169;162;162;164;161;160;163;163 10:28:59 INFO - PROCESS | 6770 | |3;audio-fft;76;76;75;178;74;76;75;75;171;77 10:28:59 INFO - PROCESS | 6770 | |4;audio-oscillator;94;91;155;93;93;93;142;95;92;151 10:28:59 INFO - PROCESS | 6770 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;118 10:28:59 INFO - PROCESS | 6770 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;146;146 10:28:59 INFO - PROCESS | 6770 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;96;95 10:28:59 INFO - PROCESS | 6770 | |8;json-parse-financial;53;55;55;54;55;61;57;79;54;54 10:28:59 INFO - PROCESS | 6770 | |9;json-stringify-tinderbox;57;57;56;61;57;56;58;58;58;58 10:28:59 INFO - PROCESS | 6770 | |10;stanford-crypto-aes;75;72;73;81;74;73;75;73;77;74 10:28:59 INFO - PROCESS | 6770 | |11;stanford-crypto-ccm;113;113;120;114;117;121;115;113;139;129 10:28:59 INFO - PROCESS | 6770 | |12;stanford-crypto-pbkdf2;170;164;164;160;162;159;164;159;160;160 10:28:59 INFO - PROCESS | 6770 | |13;stanford-crypto-sha256-iterative;66;67;67;65;67;65;63;66;65;66 10:28:59 INFO - PROCESS | 6770 | __end_tp_report 10:28:59 INFO - PROCESS | 6770 | __start_cc_report 10:28:59 INFO - PROCESS | 6770 | _x_x_mozilla_cycle_collect,825 10:28:59 INFO - PROCESS | 6770 | __end_cc_report 10:28:59 INFO - PROCESS | 6770 | __startTimestamp1464197339383__endTimestamp 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | ------- Summary: start ------- 10:28:59 INFO - PROCESS | 6770 | Number of tests: 14 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.96 (3.6%) stddev-sans-first:4.18 10:28:59 INFO - PROCESS | 6770 | Values: 108.0 112.0 105.0 111.0 114.0 111.0 100.0 109.0 110.0 109.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:161.00 stddev:19.31 (12.0%) stddev-sans-first:19.98 10:28:59 INFO - PROCESS | 6770 | Values: 163.0 132.0 152.0 170.0 133.0 163.0 159.0 128.0 181.0 128.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.40 (1.5%) stddev-sans-first:2.55 10:28:59 INFO - PROCESS | 6770 | Values: 163.0 163.0 169.0 162.0 162.0 164.0 161.0 160.0 163.0 163.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:41.78 (55.3%) stddev-sans-first:43.73 10:28:59 INFO - PROCESS | 6770 | Values: 76.0 76.0 75.0 178.0 74.0 76.0 75.0 75.0 171.0 77.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.41 (29.5%) stddev-sans-first:28.46 10:28:59 INFO - PROCESS | 6770 | Values: 94.0 91.0 155.0 93.0 93.0 93.0 142.0 95.0 92.0 151.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:28:59 INFO - PROCESS | 6770 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:28:59 INFO - PROCESS | 6770 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:28:59 INFO - PROCESS | 6770 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:55.00 stddev:7.82 (14.2%) stddev-sans-first:8.11 10:28:59 INFO - PROCESS | 6770 | Values: 53.0 55.0 55.0 54.0 55.0 61.0 57.0 79.0 54.0 54.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:1.43 (2.5%) stddev-sans-first:1.50 10:28:59 INFO - PROCESS | 6770 | Values: 57.0 57.0 56.0 61.0 57.0 56.0 58.0 58.0 58.0 58.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:2.63 (3.5%) stddev-sans-first:2.78 10:28:59 INFO - PROCESS | 6770 | Values: 75.0 72.0 73.0 81.0 74.0 73.0 75.0 73.0 77.0 74.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:118.50 stddev:8.54 (7.2%) stddev-sans-first:8.74 10:28:59 INFO - PROCESS | 6770 | Values: 113.0 113.0 120.0 114.0 117.0 121.0 115.0 113.0 139.0 129.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:3.43 (2.1%) stddev-sans-first:2.18 10:28:59 INFO - PROCESS | 6770 | Values: 170.0 164.0 164.0 160.0 162.0 159.0 164.0 159.0 160.0 160.0 10:28:59 INFO - PROCESS | 6770 | 10:28:59 INFO - PROCESS | 6770 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 10:28:59 INFO - PROCESS | 6770 | Values: 66.0 67.0 67.0 65.0 67.0 65.0 63.0 66.0 65.0 66.0 10:28:59 INFO - PROCESS | 6770 | -------- Summary: end -------- 10:28:59 INFO - PROCESS | 6770 | 10:29:00 INFO - TEST-INFO | 6770: exit 0 10:29:00 INFO - TEST-OK | kraken | took 60831ms 10:29:00 INFO - SUITE-END | took 1169s 10:29:00 INFO - Completed test suite (00:19:30) 10:29:00 INFO - javascript benchmark 10:29:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.318514704486, 3377.1725927147854, 3395.5925288965327, 3400.9829950850244, 3414.8121853298076, 5603.159526071091, 5615.775368985241, 5627.352854421748, 5628.831135065944, 5634.0, 5562.443755624446, 5582.91625625615, 5623.325200975878, 5626.746796394162, 5635.3801081881065, 5056.292119103319, 5099.490050994889, 5159.22611608258, 5165.845024649267, 5171.689698618095, 4995.600351971833, 5167.896642067157, 5237.292965449654, 5237.607179461536, 5260.842174734745, 5114.130597798383, 5126.384833819947, 5129.333186685725, 5148.124818780816, 5185.196294574328, 5063.392392912837, 5071.771770270347, 5077.695338279678, 5087.923681144785, 5120.0, 4909.0, 5000.449950505442, 5012.899742005139, 5027.195648696227, 5035.244713292998, 5362.168863826113, 5370.570354371641, 5420.186971954238, 5421.159720243369, 5442.0, 5797.942020579782, 5921.289445266596, 5924.0, 5926.288845338587, 5928.436798504178, 5767.913481297784, 5951.49412299955, 5952.7321270542925, 5953.940460595382, 5956.702164891738, 5526.143447765603, 5561.388247292794, 5563.888722225533, 5595.860103497404, 5645.971770141123, 5967.075103358986, 5983.401659833982, 5985.401459854067, 5987.191729116514, 5989.8203053908455, 5765.682887441147, 5784.0, 5796.855078623068, 5849.356570777211, 5866.6480011199465, 5853.765849366063, 5886.323072846678, 5890.823275301748, 5905.911411328833, 5930.584859059824, 5838.941610583925, 5849.941500585025, 5851.268591426072, 5862.472377486047, 5867.471927526458, 5810.82567522975, 5816.41835816415, 5881.2942446906645, 5883.470487656132, 5895.67573783446, 4532.9320060199125, 4559.6808223424705, 4561.817527298937, 4563.840265590755, 4581.381513495702, 4093.6111069448357, 4114.074333275049, 4128.318827393447, 4139.482564679415, 4159.480064991876, 5776.364599894008, 5801.8549536261935, 5807.245058142499, 5817.88364232713, 5842.766289348463, 5883.794067207627, 5971.880562388728, 5997.940020599825, 6008.4592386684535, 6052.485538729257, 5672.290963629546, 5720.11338242573, 5733.31200255972, 5746.109353050284, 5746.9712651436475, 5113.181890897438, 5136.383633963948, 5175.689458632419, 5188.481151884856, 5210.583153347723, 6178.5366097542865, 6183.628982261079, 6196.225471816023, 6207.906881396782, 6219.253689557282, 5910.408959104056, 5963.970180149072, 5992.101184822224, 6011.0, 6018.398160183947, 6122.764110201706, 6162.691865406622, 6175.783847565313, 6186.257649081959, 6200.875982480416, 5891.558133139946, 5896.911546326723, 5898.882022359615, 5923.229980102559, 5935.317438494456, 5919.141724450017, 5925.4370834770625, 5927.644341339534, 5998.160257563857, 6023.6385816851125, 5792.82621521355, 5794.0439827428, 5804.82585522435, 5808.07070868659, 5822.592418530831, 5717.971410142923, 5756.971215143897, 5757.8560535986935, 5758.71206439668, 5778.971105144447, 5581.358143813351, 5660.6037577370835, 5698.8290351289525, 5703.287089113861, 5760.1935728998815, 5864.912026319694, 5892.646441213541, 5895.616784908967, 5898.616589921641, 5930.28836539618, 5669.574781891292, 5754.194412782297, 5759.337676167127, 5767.106098554731, 5771.509421699203], "value": 5502.015739401434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.8112625649176, 652.5693042591889, 661.8246164766338, 677.8068250548595, 684.3020119478135, 39291.21417571647, 40588.188236235255, 40725.59274407255, 40892.18215635685, 41008.179836403295, 42963.57036429643, 43151.13697726044, 43370.0, 43475.34786978198, 43530.129397412034, 8703.521306328134, 8933.821323573524, 8941.150590693873, 8946.329025323093, 8969.058248883839, 8769.342299327576, 8927.285817134614, 8934.374593778439, 9147.908520914772, 9152.039035901234, 9149.63401463944, 9224.308176886727, 9286.814263714721, 9308.115729005734, 9309.953450232739, 9197.632094716204, 9203.309751768611, 9238.491882946435, 9240.214581760558, 9272.72181834546, 9036.322275829274, 9116.8632470513, 9159.954200229024, 9162.86255706165, 9190.908090919072, 42732.145357092995, 43052.56947430517, 43170.56829431697, 43363.78318108421, 43427.34858977118, 3760.567534733513, 4039.515258169009, 4235.788210589458, 4250.4899412070445, 4621.0, 32257.6774232257, 32452.675473245203, 33075.83462082698, 34256.82871585651, 34678.9596312111, 4635.096156249533, 4699.201135806921, 4706.22347312693, 4712.5051869553545, 4741.051789642085, 298624.99999999785, 298848.0, 299079.0, 300315.0, 300561.0, 39644.40533392001, 62545.37454625487, 62669.37330626635, 62707.0, 62804.685976569825, 38120.61879381226, 38138.80930595329, 38179.80910095432, 38238.6176138235, 38276.80861595674, 16701.24844382006, 16931.661366772594, 16946.40687575929, 16967.575810604587, 16969.490915272563, 13423.932880335537, 13432.059755817, 13471.259080750653, 13481.730365392834, 13588.864111358958, 9294.302927280482, 9461.290403219786, 9465.621375145054, 9489.145976862115, 9564.187044101329, 3620.2216523447587, 3679.282539904693, 3680.5583330000572, 3686.5207523021836, 3763.9059023524082, 1093.103655002906, 1094.2723089145788, 1186.1341220908785, 1208.746163305698, 1227.2697744841805, 33646.32707345839, 33747.49378759321, 33842.830785845916, 33862.32275354528, 34002.14994625105, 1157.1841851494676, 1211.7515909238762, 1217.6712287682276, 1233.6998528935062, 1275.4630670042577, 15028.849711502746, 15772.605684857741, 16074.010403986686, 16097.114658693885, 16222.675546489005, 524652.0, 537779.0, 537799.0, 555956.0, 881505.0, 58439.70780146072, 59579.404205957384, 59745.0, 59760.40239597635, 59807.40192598105, 1588.602849287678, 1589.2927647196886, 1601.3354457900075, 1610.9355625774838, 1620.1656147084261, 31048.68951310458, 31699.31867528495, 31834.52248216325, 31913.521297180097, 32599.0, 55625.721871392, 56144.438555613924, 56379.436205637416, 56385.0, 56499.30502084944, 332535.0, 338353.0, 338806.0, 339163.0, 339316.0, 46547.76726116348, 46644.0, 46935.765321173174, 47152.7642361786, 48078.27882581694, 50500.74749626228, 51257.743711281204, 51676.483235167165, 52142.739286303324, 52245.0, 42486.0, 42554.361684574134, 42601.573984261, 43225.0, 43978.34032489451, 41560.79219603883, 41755.0, 42442.0, 42998.71003869889, 43519.0, 43507.78246108749, 43641.34537981996, 44298.3355249678, 44510.9970051342, 44545.0, 36480.635193648784, 37187.42705596587, 37904.24191516209, 38154.0, 38627.2274554513, 29394.0, 29464.0, 29757.70242297636, 29914.551281731226, 29934.25164370908], "value": 19947.726155085307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.75788800383793, 431.8769150792024, 434.1277575972356, 437.40949717880864, 437.95839395257457, 18451.07744612769, 19191.520211994706, 19234.23063077477, 19321.13054912529, 20227.292044778435, 12716.809247861289, 12989.870101298984, 15082.622934426645, 20156.899215503938, 20249.291274805386, 5328.413874473805, 5573.665580065189, 5578.163275508686, 5579.972100139494, 5643.548516118721, 5864.882702345951, 6963.442924566048, 7269.781906542812, 7292.41660667148, 7302.0, 7102.538335008208, 7231.602261875595, 7707.113681926566, 7707.30634242918, 7712.5372477651235, 6885.552439091443, 7495.400367970549, 7515.699372025139, 7580.393568514533, 7598.772036838904, 6915.89626155608, 6963.338482844172, 7008.123984501937, 7013.649317534154, 7029.29707029293, 25318.49363012748, 26015.479690406275, 26151.0, 26629.334266643487, 27557.724422755717, 2718.4834881372476, 2733.3576609496754, 2794.3572978215125, 2832.1928250448727, 3104.2239440139965, 15374.692506149815, 15992.280347384396, 16528.75206871898, 16728.83271167297, 16751.748723769033, 2222.7999480046874, 2226.922057727988, 2270.2735124760084, 2313.144136669426, 2366.467544802406, 90250.0, 90274.5486272571, 91014.0, 92294.53852730761, 94002.52998735031, 18955.526111847314, 19286.132124054453, 19652.50868728293, 19970.90014549918, 20033.79966200319, 34484.0, 34547.0, 34660.747051441576, 35313.64686353155, 35457.64542354595, 7940.880886786703, 8182.631781569844, 8341.45780524276, 8348.791280217922, 8403.36974726898, 8067.233612806774, 8263.834723305501, 8264.090949995496, 8264.83470330602, 8299.087100418948, 3834.69322454203, 4042.939355909664, 4076.245894509466, 4606.124836281096, 4629.629629629621, 1895.6587814193579, 1966.8229859312444, 1968.9901550492157, 1987.0561483295608, 1989.4827344890432, 1066.7439814444479, 1078.1536493852288, 1086.5436516663021, 1186.454231053725, 1186.6321440353345, 18769.249230030648, 18848.340308089424, 19059.61880762377, 19243.422697319103, 19561.902190488956, 1046.2676126711333, 1110.1230028277732, 1127.3461392392392, 1145.095374654014, 1166.7141550320225, 10595.629152979609, 10769.9461502692, 10891.237613367146, 10926.617568385069, 11054.115670746321, 519698.0, 522148.0, 524542.0, 526925.0, 535838.0, 92577.537112314, 92887.0, 93533.53233233927, 93697.0, 93733.5313323429, 1127.689885281554, 1130.2822707580744, 1149.7872893514727, 1154.9018333441584, 1155.3183621663259, 16768.916155419145, 16776.0, 16784.752516570326, 17110.0, 17140.314387424864, 27473.17580472589, 33306.33387332191, 38505.807470963584, 39159.02102447348, 39531.40702889401, 54812.0, 56799.71600141973, 56805.43194568167, 57183.142252867074, 57747.13379299398, 8698.956505217433, 8836.204741573289, 8949.105089490999, 9026.142516460926, 9134.086591340812, 13151.473941042252, 13158.078934474877, 13224.537141200011, 13293.20240785556, 13333.266670333225, 11853.703657408634, 11919.404029798648, 12018.038556915251, 12062.276263424223, 12184.634460966185, 11712.590059347882, 11775.843427221915, 11877.940610297239, 12338.691532711755, 12358.876411235773, 11934.0, 12045.63863084109, 12172.45223964906, 12244.693882653006, 12291.139620226499, 8666.696665616673, 8691.91308086911, 8944.105589441004, 9020.233280171258, 9138.634454622006, 11769.411529423665, 11791.705207369541, 11837.940810295893, 11842.348670823187, 11972.700682482659], "value": 10215.774572628537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.6175956010998, 1552.076514473888, 1768.3633891798959, 1845.3264558436174, 1873.6533741257867, 7383.335499805016, 8265.586720663965, 8266.090730019692, 8420.031696354921, 8469.491830490175, 8146.91853081469, 8331.500109993389, 8339.082700902896, 8340.541270230135, 8368.707095251668, 2364.929052128439, 2402.411409204747, 2402.7236867760257, 2418.842775219614, 2424.8181386396004, 2306.08909480755, 2326.5928462519078, 2329.801966832821, 2346.120204923154, 2364.43253619131, 2396.9640455393182, 2417.3593997590565, 2418.3833122553724, 2430.0279888044834, 2437.597796363598, 2392.3540644026016, 2411.915582954597, 2423.3941514621347, 2424.187897054489, 2425.7938075263623, 2297.1270917051415, 2357.0, 2358.646203069536, 2368.5026144509675, 2373.8575685458927, 8402.327813774884, 8436.0, 8460.36547258952, 8476.110008449148, 8509.361797865186, 5321.920171197435, 5433.293671822677, 5438.755256013489, 5448.346198456211, 5448.673079615196, 3467.1450773835877, 3525.964740352589, 3595.209054008114, 3596.4245720684826, 3632.8728494502566, 1121.1871393239917, 1129.7232178116415, 1139.549877798265, 1166.1836714300025, 1168.0480408467072, 11964.0, 11974.22167559106, 12086.033117350591, 12121.757564848742, 12152.0, 4775.61889732718, 4807.927881081787, 4814.614830813526, 4914.778834952435, 4921.212605983097, 10136.44249566281, 10246.53890574926, 10249.590016399261, 10252.487375631337, 10281.126104281071, 5309.65487243328, 5393.110136827379, 5396.514313711785, 5399.325084364455, 5408.783648654088, 4364.803583838735, 4644.558766917137, 4718.079974404958, 4738.549837765407, 4945.406551213878, 4092.6725861930972, 4154.543000269968, 4170.812313445902, 4177.0, 4353.891152721144, 1364.283751030697, 1380.7307575022976, 1395.239594421043, 1397.82527184102, 1398.210011343608, 971.8347880860271, 1021.8810402609131, 1057.0856209378833, 1067.4555976451911, 1076.1175835814713, 5660.632058916157, 5732.082866741302, 5772.5959182856795, 5872.324682661463, 5947.0, 1019.2966852871494, 1058.5977328615077, 1097.2977294531506, 1107.6234080412698, 1109.9389533575732, 4010.8195131219163, 4062.4921884764403, 4067.5322337930925, 4088.713790034669, 4091.734037287567, 10560.683179504627, 10652.520636571373, 10716.571337146426, 10743.78512429747, 10764.192685548614, 10434.16526677864, 10530.420826854597, 10584.682459526226, 10600.098991585648, 10600.946995264974, 8114.63484143215, 8159.347252219808, 8262.462939908886, 8274.420790544724, 8275.379346549033, 5704.914426283526, 5770.365259821332, 5802.47777700009, 5875.911861321998, 5907.586468947133, 9196.172344489029, 9206.677766278148, 9288.210502107397, 9348.971613122687, 9428.340016198801, 9250.676226332045, 9474.24206063527, 9491.477968711511, 9545.28410369239, 9603.615855365708, 6618.106555614931, 7046.718131274896, 7270.600116993616, 7336.082989626297, 7435.442341824277, 8167.836643266983, 8193.50838949665, 8202.548859812767, 8215.794605134919, 8255.215754503313, 7134.1795693495915, 7290.817729556804, 7323.121225452766, 7334.816629584089, 7499.62501874915, 7105.18290396611, 7114.964425177841, 7129.21578626361, 7133.179684336368, 7431.628418579157, 6359.459445947146, 6389.265234497906, 6389.616623002449, 6402.103705481143, 6415.8716825662295, 4787.640926930424, 4914.1154592172325, 4921.803127874845, 4956.355673762388, 4975.4278258000795, 5162.741862906914, 5217.791288348423, 5223.3209682741, 5261.210818377274, 5292.894142117213], "value": 4632.336209522352, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.808241631935, 362.7696412777886, 363.76355369010156, 365.63984475291835, 368.2726614935503, 6659.0, 6690.029945657883, 6723.327667233274, 6750.594964302145, 6765.864682706343, 6614.272430032693, 6617.33826617338, 6621.205455345354, 6625.0, 6631.27056023837, 4756.66703330767, 4853.466118726938, 5008.323876276692, 5008.974955125237, 5030.06943715412, 4981.72600506972, 5005.324281222025, 5007.799688012475, 5013.273075404064, 5015.84952451427, 4954.331165292675, 4956.107900577895, 4986.927810520738, 4988.650794444372, 4988.950110498885, 4979.7261150636705, 4989.476105008958, 4995.250712393152, 5001.374828146481, 5003.649744517885, 4367.781610919441, 4376.059147283349, 4376.299792033259, 4384.057427653038, 4387.3857659927635, 6124.448799608057, 6300.905486417708, 6361.2048493938255, 6366.0, 6399.424051835357, 5698.857528561819, 5714.79998200061, 5723.826615543803, 5779.797707080274, 5789.623674461147, 7001.264867188923, 7005.754798582026, 7011.719531218745, 7013.298670132997, 7014.894776578355, 4784.425868895755, 4788.664793464459, 4794.688345257547, 4798.088363210979, 4801.327814106028, 7179.605121718356, 7219.530730502501, 7290.161631412402, 7295.306945840137, 7300.780976570712, 4877.878053048631, 4881.560659540658, 4895.902081958341, 4901.877453063702, 4903.141950158708, 4915.090708218991, 4931.901361972812, 4932.679375840559, 4947.6536642434685, 4964.05682920244, 5740.971295143498, 5755.0791873300905, 5772.365039845614, 5773.88452230953, 5775.191473193756, 6985.860282794316, 7000.824979375557, 7021.684024218923, 7040.964795175992, 7049.154101507749, 1734.0, 1765.823417658224, 1768.5224989253088, 1773.122304459301, 1773.973390399145, 1114.0975809594254, 1132.2074547816562, 1134.7106487845713, 1141.5034460009756, 1149.3046706742468, 6626.138601981712, 6626.83432914181, 6765.9661701691175, 6817.318268173143, 6819.283975182633, 7129.108861392326, 7173.569585824867, 7188.784336469915, 7214.386777124003, 7244.420446364278, 6835.111435513351, 6886.621235831977, 6901.930980690229, 6902.585844849325, 6905.75829845953, 3911.2177564487215, 3935.74417662851, 3958.7228893977144, 3960.2475529649273, 3969.0871099647243, 7588.241175882367, 7632.274933881273, 7654.693812247559, 7668.271514206142, 7676.462647614613, 7356.485046046725, 7503.137139229058, 7509.3617042552, 7533.472656914073, 7567.962160189274, 7631.122420921554, 7688.154303026663, 7698.0, 7726.6136693166245, 7772.0, 7344.449166312441, 7358.411327093927, 7362.5214361066355, 7364.815879603053, 7370.299821516947, 7332.816679583053, 7334.926650733638, 7337.229590893093, 7341.229170936975, 7370.336669699753, 7472.252774722484, 7674.961625192062, 7681.884771728317, 7698.0, 7705.499142555716, 5057.165567681292, 5071.315372424823, 5093.541581257705, 5096.23556466533, 5105.183170692671, 7182.317679820409, 7224.711011559689, 7244.203137654959, 7259.854802903807, 7261.455390845602, 7011.404030657452, 7033.613151276524, 7036.612986285803, 7071.469639776935, 7088.0, 6831.453483721191, 6989.510734248757, 7065.364117229474, 7079.964600176966, 7095.787126386217, 6930.237673855972, 6943.861122777617, 6948.652567371712, 6981.895271570829, 6995.860082798417, 7095.716171353294, 7109.040279562193, 7135.785926422215, 7147.678354474165, 7157.0, 6783.559068660521, 6872.965635171792, 6937.410320122644, 6980.546264492792, 6981.02265682815], "value": 5292.591458483071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.653203920373, 851.940364174508, 878.3079860228396, 895.4671970177742, 897.6364572348198, 14247.501337453179, 14529.636759081028, 14742.63143421415, 14746.262686865668, 14746.778798318033, 13401.92784577234, 13434.731305373887, 13544.593662190126, 13551.59345219645, 13559.457621695145, 754.9320561149495, 892.1479986612769, 899.883015208022, 906.759708677201, 914.9542522873863, 898.1961144775422, 898.3217670658644, 906.5784410249232, 907.419251678926, 908.6865031564133, 950.6054987180312, 955.3599088610613, 957.5116690487831, 957.6887511558771, 961.1157734883889, 954.3796532254021, 955.4458414119794, 956.273232343417, 956.3974695941582, 958.228625956105, 690.2234985641154, 692.3076923076923, 693.7918624412706, 700.9018737376771, 704.6899364279752, 14977.700445991019, 15075.47235846751, 15094.471693490676, 15113.093214407061, 15197.772033419507, 14578.0, 14778.0, 14813.481528146463, 14907.0, 14930.47743328989, 11369.374684392355, 11557.711057223552, 11687.883121168765, 11811.94094029533, 11915.523379064827, 3922.333203355408, 3960.1683646434285, 4059.6955228357992, 4145.937810932838, 4155.439015732898, 54123.0, 54173.45826541723, 55268.44731552713, 56845.14732279019, 57068.143977840366, 11225.382603956697, 11359.716007099889, 11374.090072794157, 11391.886081139248, 11545.249558778652, 20093.09581068826, 20159.899200503904, 20186.39440816778, 20234.291799786937, 20469.795302047085, 8878.0, 9010.63957441708, 9038.09619038104, 9117.680881169128, 9147.771305717277, 4900.485449027872, 4904.239842824368, 4912.410510738734, 4914.778834952435, 4935.087008903364, 3416.2825806580895, 3509.298140371885, 3523.436250199956, 3524.1718196223865, 3531.6821486065865, 633.5375176121457, 641.8074577626693, 642.0465608571268, 643.7457204404234, 656.8981807819796, 602.5149754447624, 727.3526561360394, 752.2289653105502, 753.5516367761173, 756.481809960179, 9186.26509879208, 9255.861162082574, 9318.72043838686, 9326.0, 9385.15533601979, 664.2095905871997, 703.2088899987514, 767.4512723402794, 773.7949443397504, 778.2528772378466, 4248.086661367759, 4257.574242575718, 4263.253930562201, 4268.743875367488, 4378.233809083461, 63057.68471157615, 63062.36937630565, 64495.0, 65050.67474662596, 65209.347906521274, 56958.14562781562, 57044.144337834965, 57659.42340576625, 58507.41492585105, 59342.703286483295, 50907.0, 51627.0, 51694.483055169716, 51805.74097129566, 52245.2163217552, 8424.199701028392, 8533.786655333666, 8576.356773241907, 8578.18507241811, 8774.034856165945, 38315.808420957714, 38849.0, 38861.0, 38937.6106238934, 39520.60479395284, 45150.54849451595, 45551.772241138584, 47674.76162619165, 49286.75356623194, 50135.0, 11498.137639677225, 11647.941760291144, 12762.553310634083, 13074.869251307746, 13077.869221307665, 13663.453461861813, 13803.17180969145, 13830.930845345709, 13903.721925561635, 14333.64165895861, 12154.878451215374, 12755.362231888554, 12973.54592589255, 13080.542181023618, 13205.471781128646, 13237.669058273621, 13432.307883920786, 13467.595972120853, 13492.460301587827, 13519.864801352254, 12555.183913045623, 12580.433880475217, 12729.0, 12782.936085319514, 13274.203547787163, 10331.173506119643, 10668.199885008811, 10833.29583577065, 11243.269187502787, 11267.718307042389, 10539.367637941748, 10632.202584806017, 10692.786144277226, 10762.139028877828, 10885.183611229348], "value": 7045.118715609798, "unit": "score"}], "name": "dromaeo_css", "value": 7606.418723355826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 105.0, 111.0, 114.0, 111.0, 100.0, 109.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 152.0, 170.0, 133.0, 163.0, 159.0, 128.0, 181.0, 128.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 169.0, 162.0, 162.0, 164.0, 161.0, 160.0, 163.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 178.0, 74.0, 76.0, 75.0, 75.0, 171.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 155.0, 93.0, 93.0, 93.0, 142.0, 95.0, 92.0, 151.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 54.0, 55.0, 61.0, 57.0, 79.0, 54.0, 54.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 61.0, 57.0, 56.0, 58.0, 58.0, 58.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 73.0, 81.0, 74.0, 73.0, 75.0, 73.0, 77.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 120.0, 114.0, 117.0, 121.0, 115.0, 113.0, 139.0, 129.0], "value": 119.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 164.0, 164.0, 160.0, 162.0, 159.0, 164.0, 159.0, 160.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 67.0, 65.0, 63.0, 66.0, 65.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1524.0000000000002, "alertThreshold": 2.0}]} 10:29:00 INFO - Return code: 0 10:29:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:29:00 ERROR - # TBPL SUCCESS # 10:29:00 INFO - Running post-action listener: _resource_record_post_action 10:29:00 INFO - Running post-run listener: _resource_record_post_run 10:29:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 307200; Write bytes: 252608512; Read time: 92; Write time: 214620 10:29:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7577600; Read time: 0; Write time: 2400 10:29:01 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 307200; Write bytes: 245030912; Read time: 92; Write time: 212220 10:29:01 INFO - Running post-run listener: _upload_blobber_files 10:29:01 INFO - Blob upload gear active. 10:29:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:01 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:29:01 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:29:01 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:29:02 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:03 INFO - (blobuploader) - INFO - Done attempting. 10:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:03 INFO - (blobuploader) - INFO - Done attempting. 10:29:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:03 INFO - Return code: 0 10:29:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e92938f7df4dd5b99b2d8a284c0e514a85221a052acf8faf62959a6da2528579bfbb6e6396c7fe502c53c44b8568ad50bb312d2ca77cc2bdfe7dee6bac995875", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f38862fc129c1fd6275e2c85a828d7bb81434a1717d516b7f6baa48d157854d8ed0a45e0c22b20c5acba2fe0f73b72f856d1c7ab7f6efbc34f3dcc6ab376feb"} 10:29:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:03 INFO - Contents: 10:29:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e92938f7df4dd5b99b2d8a284c0e514a85221a052acf8faf62959a6da2528579bfbb6e6396c7fe502c53c44b8568ad50bb312d2ca77cc2bdfe7dee6bac995875", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f38862fc129c1fd6275e2c85a828d7bb81434a1717d516b7f6baa48d157854d8ed0a45e0c22b20c5acba2fe0f73b72f856d1c7ab7f6efbc34f3dcc6ab376feb"} 10:29:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:03 INFO - Copying logs to upload dir... 10:29:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.145978 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-25 10:29:04.004055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:29:04.007975) ========= 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=7de08804244eb36560b44971000001c3-1464196115.372422-1300823126 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/e92938f7df4dd5b99b2d8a284c0e514a85221a052acf8faf62959a6da2528579bfbb6e6396c7fe502c53c44b8568ad50bb312d2ca77cc2bdfe7dee6bac995875", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f38862fc129c1fd6275e2c85a828d7bb81434a1717d516b7f6baa48d157854d8ed0a45e0c22b20c5acba2fe0f73b72f856d1c7ab7f6efbc34f3dcc6ab376feb"} build_url:https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/Sj2dJb4nS6O1_xgm8Wmiow/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/e92938f7df4dd5b99b2d8a284c0e514a85221a052acf8faf62959a6da2528579bfbb6e6396c7fe502c53c44b8568ad50bb312d2ca77cc2bdfe7dee6bac995875", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f38862fc129c1fd6275e2c85a828d7bb81434a1717d516b7f6baa48d157854d8ed0a45e0c22b20c5acba2fe0f73b72f856d1c7ab7f6efbc34f3dcc6ab376feb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:29:04.037231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:29:04.037594) ========= 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=7de08804244eb36560b44971000001c3-1464196115.372422-1300823126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:29:04.121667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:29:04.122027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:29:04.122395) ========= ========= Total master_lag: 0.18 =========