builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1465221637.99 results: success (0) buildid: 20160606010529 builduid: 78750d9664274d05bee96204469a3a74 revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:37.994475) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:37.994924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:37.995207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:38.014726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:38.015049) ========= 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=eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 07:00:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.9M=0s 2016-06-06 07:00:38 (99.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:38.142792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:38.143186) ========= 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=eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:38.192662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 07:00:38.192993) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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 d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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=eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 07:00:38,732 truncating revision to first 12 chars 2016-06-06 07:00:38,732 Setting DEBUG logging. 2016-06-06 07:00:38,732 attempt 1/10 2016-06-06 07:00:38,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8adb38dd576?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 07:00:39,683 unpacking tar archive at: mozilla-aurora-d8adb38dd576/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270067 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 07:00:39.476742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.477058) ========= script_repo_revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.477505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.477795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.486862) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-06 07:00:39.487196) ========= /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=eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:40 INFO - MultiFileLogger online at 20160606 07:00:40 in /builds/slave/test 07:00:40 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 07:00:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:00:40 INFO - {'append_to_log': False, 07:00:40 INFO - 'base_work_dir': '/builds/slave/test', 07:00:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:00:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:00:40 INFO - 'branch': 'Mozilla-Aurora', 07:00:40 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:40 INFO - 'config_files': ('talos/linux_config.py',), 07:00:40 INFO - 'default_actions': ('clobber', 07:00:40 INFO - 'read-buildbot-config', 07:00:40 INFO - 'download-and-extract', 07:00:40 INFO - 'populate-webroot', 07:00:40 INFO - 'create-virtualenv', 07:00:40 INFO - 'install', 07:00:40 INFO - 'run-tests'), 07:00:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:40 INFO - 'download_minidump_stackwalk': True, 07:00:40 INFO - 'download_symbols': 'ondemand', 07:00:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:40 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:40 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:40 INFO - 'installer_path': 'installer.exe', 07:00:40 INFO - 'log_level': 'info', 07:00:40 INFO - 'log_name': 'talos', 07:00:40 INFO - 'log_to_console': True, 07:00:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:40 INFO - 'opt_config_files': (), 07:00:40 INFO - 'pip_index': False, 07:00:40 INFO - 'sps_profile': False, 07:00:40 INFO - 'sps_profile_interval': 0, 07:00:40 INFO - 'suite': 'dromaeojs-e10s', 07:00:40 INFO - 'system_bits': '32', 07:00:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:40 INFO - 'title': 'talos-linux64-ix-010', 07:00:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:40 INFO - 'use_talos_json': True, 07:00:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:00:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:40 INFO - 'work_dir': 'build'} 07:00:40 INFO - ##### 07:00:40 INFO - ##### Running clobber step. 07:00:40 INFO - ##### 07:00:40 INFO - Running pre-action listener: _resource_record_pre_action 07:00:40 INFO - Running main action method: clobber 07:00:40 INFO - rmtree: /builds/slave/test/build 07:00:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:00:40 INFO - Running post-action listener: _resource_record_post_action 07:00:40 INFO - ##### 07:00:40 INFO - ##### Running read-buildbot-config step. 07:00:40 INFO - ##### 07:00:40 INFO - Running pre-action listener: _resource_record_pre_action 07:00:40 INFO - Running main action method: read_buildbot_config 07:00:40 INFO - Using buildbot properties: 07:00:40 INFO - { 07:00:40 INFO - "project": "", 07:00:40 INFO - "product": "firefox", 07:00:40 INFO - "script_repo_revision": "production", 07:00:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:00:40 INFO - "repository": "", 07:00:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:00:40 INFO - "buildid": "20160606010529", 07:00:40 INFO - "pgo_build": "True", 07:00:40 INFO - "basedir": "/builds/slave/test", 07:00:40 INFO - "buildnumber": 334, 07:00:40 INFO - "slavename": "talos-linux64-ix-010", 07:00:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:00:40 INFO - "platform": "ubuntu64_hw", 07:00:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:00:40 INFO - "branch": "mozilla-aurora", 07:00:40 INFO - "repo_path": "releases/mozilla-aurora", 07:00:40 INFO - "revision": "d8adb38dd576398dacbfb96d2c247f8e0158bdf1", 07:00:40 INFO - "stage_platform": "linux64-pgo", 07:00:40 INFO - "builduid": "78750d9664274d05bee96204469a3a74", 07:00:40 INFO - "slavebuilddir": "test" 07:00:40 INFO - } 07:00:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:00:40 INFO - Running post-action listener: _resource_record_post_action 07:00:40 INFO - ##### 07:00:40 INFO - ##### Running download-and-extract step. 07:00:40 INFO - ##### 07:00:40 INFO - Running pre-action listener: _resource_record_pre_action 07:00:40 INFO - Running main action method: download_and_extract 07:00:40 INFO - mkdir: /builds/slave/test/build/tests 07:00:40 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')]} 07:00:40 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:41 INFO - Downloaded 1361 bytes. 07:00:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:00:41 INFO - Using the following test package requirements: 07:00:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:00:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:00:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'jsshell-linux-x86_64.zip'], 07:00:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:00:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:00:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:00:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00: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')]} 07:00:41 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:42 INFO - Downloaded 24177411 bytes. 07:00: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'] 07:00: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 07:00:43 INFO - Return code: 0 07:00:43 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 07:00: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')]} 07:00:43 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:44 INFO - Downloaded 24177411 bytes. 07:00:44 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'] 07:00:44 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 07:00:46 INFO - Return code: 0 07:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:46 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:00:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:00:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:47 INFO - Downloaded 10840145 bytes. 07:00:47 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'] 07:00:47 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 07:00:47 INFO - Return code: 0 07:00:47 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')]} 07:00:47 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 07:00:50 INFO - Downloaded 62805945 bytes. 07:00:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:50 INFO - mkdir: /builds/slave/test/properties 07:00:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:50 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:50 INFO - Contents: 07:00:50 INFO - build_url:https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:51 INFO - Running post-action listener: _resource_record_post_action 07:00:51 INFO - Running post-action listener: set_extra_try_arguments 07:00:51 INFO - ##### 07:00:51 INFO - ##### Running populate-webroot step. 07:00:51 INFO - ##### 07:00:51 INFO - Running pre-action listener: _resource_record_pre_action 07:00:51 INFO - Running main action method: populate_webroot 07:00:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:51 INFO - '--tppagecycles', 07:00:51 INFO - '7'], 07:00:51 INFO - 'tests': ['tsvgm']}}, 07:00:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['damp', 'tps']}, 07:00:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'tests': ['damp', 'tps']}, 07:00:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['dromaeo_dom']}, 07:00:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tsvgx', 07:00:51 INFO - 'tsvgr_opacity', 07:00:51 INFO - 'tart', 07:00:51 INFO - 'tscrollx', 07:00:51 INFO - 'cart']}, 07:00:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:51 INFO - 'tsvgr_opacity', 07:00:51 INFO - 'tart', 07:00:51 INFO - 'tscrollx', 07:00:51 INFO - 'cart']}, 07:00:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tp5o']}, 07:00:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'tests': ['tp5o']}, 07:00:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s', 07:00:51 INFO - '--xperf_path', 07:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:51 INFO - 'tests': ['tp5n']}, 07:00:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--xperf_path', 07:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:51 INFO - 'tests': ['tp5n']}}, 07:00:51 INFO - 'talos.zip': {'path': '', 07:00:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:51 INFO - Running post-action listener: _resource_record_post_action 07:00:51 INFO - ##### 07:00:51 INFO - ##### Running create-virtualenv step. 07:00:51 INFO - ##### 07:00:51 INFO - Running pre-action listener: _resource_record_pre_action 07:00:51 INFO - Running main action method: create_virtualenv 07:00:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:51 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 07:00:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:51 INFO - Using real prefix '/usr' 07:00:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:51 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:53 INFO - Installing pip.................done. 07:00:53 INFO - Return code: 0 07:00:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:53 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')]} 07:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:53 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')]} 07:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:53 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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:00:53 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 07:00:53 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 07:00:53 INFO - Using env: {'DISPLAY': ':0', 07:00:53 INFO - 'HOME': '/home/cltbld', 07:00:53 INFO - 'LANG': 'en_US.UTF-8', 07:00:53 INFO - 'LANGUAGE': 'en_US:en', 07:00:53 INFO - 'LOGNAME': 'cltbld', 07:00:53 INFO - 'MAIL': '/var/mail/cltbld', 07:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:53 INFO - 'MOZ_NO_REMOTE': '1', 07:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:53 INFO - 'NO_EM_RESTART': '1', 07:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:53 INFO - 'PWD': '/builds/slave/test', 07:00:53 INFO - 'SHELL': '/bin/bash', 07:00:53 INFO - 'SHLVL': '1', 07:00:53 INFO - 'TERM': 'linux', 07:00:53 INFO - 'TMOUT': '86400', 07:00:53 INFO - 'USER': 'cltbld', 07:00:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:53 INFO - '_': '/tools/buildbot/bin/python'} 07:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:53 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 07:00:53 INFO - Cleaning up... 07:00:53 INFO - Return code: 0 07:00:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:00:53 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')]} 07:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:53 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')]} 07:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:53 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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:00:53 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 07:00:53 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 07:00:53 INFO - Using env: {'DISPLAY': ':0', 07:00:53 INFO - 'HOME': '/home/cltbld', 07:00:53 INFO - 'LANG': 'en_US.UTF-8', 07:00:53 INFO - 'LANGUAGE': 'en_US:en', 07:00:53 INFO - 'LOGNAME': 'cltbld', 07:00:53 INFO - 'MAIL': '/var/mail/cltbld', 07:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:53 INFO - 'MOZ_NO_REMOTE': '1', 07:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:53 INFO - 'NO_EM_RESTART': '1', 07:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:53 INFO - 'PWD': '/builds/slave/test', 07:00:53 INFO - 'SHELL': '/bin/bash', 07:00:53 INFO - 'SHLVL': '1', 07:00:53 INFO - 'TERM': 'linux', 07:00:53 INFO - 'TMOUT': '86400', 07:00:53 INFO - 'USER': 'cltbld', 07:00:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:53 INFO - '_': '/tools/buildbot/bin/python'} 07:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:54 INFO - Downloading/unpacking psutil>=0.7.1 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:56 INFO - Installing collected packages: psutil 07:00:56 INFO - Running setup.py install for psutil 07:00:56 INFO - building 'psutil._psutil_linux' extension 07:00:56 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 07:00:56 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 07:00:56 INFO - building 'psutil._psutil_posix' extension 07:00:56 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 07:00:56 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 07:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:56 INFO - Successfully installed psutil 07:00:56 INFO - Cleaning up... 07:00:56 INFO - Return code: 0 07:00:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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', '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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:00: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:00: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 mozsystemmonitor==0.0.0 07:00:56 INFO - Using env: {'DISPLAY': ':0', 07:00:56 INFO - 'HOME': '/home/cltbld', 07:00:56 INFO - 'LANG': 'en_US.UTF-8', 07:00:56 INFO - 'LANGUAGE': 'en_US:en', 07:00:56 INFO - 'LOGNAME': 'cltbld', 07:00:56 INFO - 'MAIL': '/var/mail/cltbld', 07:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:56 INFO - 'MOZ_NO_REMOTE': '1', 07:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:56 INFO - 'NO_EM_RESTART': '1', 07:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:56 INFO - 'PWD': '/builds/slave/test', 07:00:56 INFO - 'SHELL': '/bin/bash', 07:00:56 INFO - 'SHLVL': '1', 07:00:56 INFO - 'TERM': 'linux', 07:00:56 INFO - 'TMOUT': '86400', 07:00:56 INFO - 'USER': 'cltbld', 07:00:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:56 INFO - '_': '/tools/buildbot/bin/python'} 07:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:00:56 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 07:00:56 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 07:00:56 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 07:00:56 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 07:00:56 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 07:00:56 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 07:00:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:00:58 INFO - Installing collected packages: mozsystemmonitor 07:00:58 INFO - Running setup.py install for mozsystemmonitor 07:00:58 INFO - Successfully installed mozsystemmonitor 07:00:58 INFO - Cleaning up... 07:00:58 INFO - Return code: 0 07:00:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:00:58 INFO - Using env: {'DISPLAY': ':0', 07:00:58 INFO - 'HOME': '/home/cltbld', 07:00:58 INFO - 'LANG': 'en_US.UTF-8', 07:00:58 INFO - 'LANGUAGE': 'en_US:en', 07:00:58 INFO - 'LOGNAME': 'cltbld', 07:00:58 INFO - 'MAIL': '/var/mail/cltbld', 07:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:58 INFO - 'MOZ_NO_REMOTE': '1', 07:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:58 INFO - 'NO_EM_RESTART': '1', 07:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:58 INFO - 'PWD': '/builds/slave/test', 07:00:58 INFO - 'SHELL': '/bin/bash', 07:00:58 INFO - 'SHLVL': '1', 07:00:58 INFO - 'TERM': 'linux', 07:00:58 INFO - 'TMOUT': '86400', 07:00:58 INFO - 'USER': 'cltbld', 07:00:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:58 INFO - '_': '/tools/buildbot/bin/python'} 07:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:01:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:01:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 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 07:01:01 INFO - Downloading docopt-0.6.1.tar.gz 07:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:01:01 INFO - Running setup.py install for blobuploader 07:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:01:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:01:01 INFO - Running setup.py install for requests 07:01:02 INFO - Running setup.py install for docopt 07:01:02 INFO - Successfully installed blobuploader requests docopt 07:01:02 INFO - Cleaning up... 07:01:02 INFO - Return code: 0 07:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:02 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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:01:02 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 07:01:02 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 07:01:02 INFO - Using env: {'DISPLAY': ':0', 07:01:02 INFO - 'HOME': '/home/cltbld', 07:01:02 INFO - 'LANG': 'en_US.UTF-8', 07:01:02 INFO - 'LANGUAGE': 'en_US:en', 07:01:02 INFO - 'LOGNAME': 'cltbld', 07:01:02 INFO - 'MAIL': '/var/mail/cltbld', 07:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:02 INFO - 'MOZ_NO_REMOTE': '1', 07:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:02 INFO - 'NO_EM_RESTART': '1', 07:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:02 INFO - 'PWD': '/builds/slave/test', 07:01:02 INFO - 'SHELL': '/bin/bash', 07:01:02 INFO - 'SHLVL': '1', 07:01:02 INFO - 'TERM': 'linux', 07:01:02 INFO - 'TMOUT': '86400', 07:01:02 INFO - 'USER': 'cltbld', 07:01:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:02 INFO - '_': '/tools/buildbot/bin/python'} 07:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:02 INFO - Running setup.py (path:/tmp/pip-oNxv1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:02 INFO - Running setup.py (path:/tmp/pip-vp4Z1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:02 INFO - Running setup.py (path:/tmp/pip-QR7wkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:02 INFO - Running setup.py (path:/tmp/pip-qYJJHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:02 INFO - Running setup.py (path:/tmp/pip-e3C_Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:02 INFO - Running setup.py (path:/tmp/pip-UPRR63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:02 INFO - Running setup.py (path:/tmp/pip-dUOHaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:03 INFO - Running setup.py (path:/tmp/pip-M1jQqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:03 INFO - Running setup.py (path:/tmp/pip-oD3ZA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:03 INFO - Running setup.py (path:/tmp/pip-gfWMXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:03 INFO - Running setup.py (path:/tmp/pip-4o7z6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:03 INFO - Running setup.py (path:/tmp/pip-QEfYKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:03 INFO - Running setup.py (path:/tmp/pip-V8tLpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:03 INFO - Running setup.py (path:/tmp/pip-SwsmgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:03 INFO - Running setup.py (path:/tmp/pip-j_rmKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:03 INFO - Running setup.py (path:/tmp/pip-n0tZZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:03 INFO - Running setup.py (path:/tmp/pip-IE_Sd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:01:03 INFO - Running setup.py install for manifestparser 07:01:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:01:03 INFO - Running setup.py install for mozcrash 07:01:03 INFO - Running setup.py install for mozdebug 07:01:04 INFO - Running setup.py install for mozdevice 07:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozfile 07:01:04 INFO - Running setup.py install for mozhttpd 07:01:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozinfo 07:01:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozInstall 07:01:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozleak 07:01:04 INFO - Running setup.py install for mozlog 07:01:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for moznetwork 07:01:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozprocess 07:01:05 INFO - Running setup.py install for mozprofile 07:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozrunner 07:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozscreenshot 07:01:05 INFO - Running setup.py install for moztest 07:01:05 INFO - Running setup.py install for mozversion 07:01:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:01:05 INFO - Cleaning up... 07:01:05 INFO - Return code: 0 07:01:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:05 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')]} 07:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:05 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')]} 07:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:05 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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:01:05 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 07:01:05 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 07:01:05 INFO - Using env: {'DISPLAY': ':0', 07:01:05 INFO - 'HOME': '/home/cltbld', 07:01:05 INFO - 'LANG': 'en_US.UTF-8', 07:01:05 INFO - 'LANGUAGE': 'en_US:en', 07:01:05 INFO - 'LOGNAME': 'cltbld', 07:01:05 INFO - 'MAIL': '/var/mail/cltbld', 07:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:05 INFO - 'MOZ_NO_REMOTE': '1', 07:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:05 INFO - 'NO_EM_RESTART': '1', 07:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:05 INFO - 'PWD': '/builds/slave/test', 07:01:05 INFO - 'SHELL': '/bin/bash', 07:01:05 INFO - 'SHLVL': '1', 07:01:05 INFO - 'TERM': 'linux', 07:01:05 INFO - 'TMOUT': '86400', 07:01:05 INFO - 'USER': 'cltbld', 07:01:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:05 INFO - '_': '/tools/buildbot/bin/python'} 07:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:05 INFO - Running setup.py (path:/tmp/pip-nRxxtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:05 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)) 07:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:05 INFO - Running setup.py (path:/tmp/pip-3a_3iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:05 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)) 07:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:05 INFO - Running setup.py (path:/tmp/pip-2J5TB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:06 INFO - Running setup.py (path:/tmp/pip-Sg0E90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:06 INFO - Running setup.py (path:/tmp/pip-DhkMGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:06 INFO - Running setup.py (path:/tmp/pip-XlKzBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:06 INFO - Running setup.py (path:/tmp/pip-62nabg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:06 INFO - Running setup.py (path:/tmp/pip-a4Oxh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:06 INFO - Running setup.py (path:/tmp/pip-6yNmXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:06 INFO - Running setup.py (path:/tmp/pip-RzNvcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:06 INFO - Running setup.py (path:/tmp/pip-mwbp0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:06 INFO - Running setup.py (path:/tmp/pip-zxD6Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:06 INFO - Running setup.py (path:/tmp/pip-577QoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:06 INFO - Running setup.py (path:/tmp/pip-g805Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:06 INFO - Running setup.py (path:/tmp/pip-RyA1Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:06 INFO - Running setup.py (path:/tmp/pip-QCJ00c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:06 INFO - Running setup.py (path:/tmp/pip-8yFgMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:07 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)) 07:01:07 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)) 07:01:07 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)) 07:01:07 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)) 07:01:07 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)) 07:01:07 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)) 07:01:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:08 INFO - Downloading blessings-1.6.tar.gz 07:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:01:08 INFO - Installing collected packages: blessings 07:01:08 INFO - Running setup.py install for blessings 07:01:09 INFO - Successfully installed blessings 07:01:09 INFO - Cleaning up... 07:01:09 INFO - Return code: 0 07:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:09 INFO - Reading from file tmpfile_stdout 07:01:09 INFO - Current package versions: 07:01:09 INFO - argparse == 1.2.1 07:01:09 INFO - blessings == 1.6 07:01:09 INFO - blobuploader == 1.2.4 07:01:09 INFO - docopt == 0.6.1 07:01:09 INFO - manifestparser == 1.1 07:01:09 INFO - mozInstall == 1.12 07:01:09 INFO - mozcrash == 0.17 07:01:09 INFO - mozdebug == 0.1 07:01:09 INFO - mozdevice == 0.48 07:01:09 INFO - mozfile == 1.2 07:01:09 INFO - mozhttpd == 0.7 07:01:09 INFO - mozinfo == 0.9 07:01:09 INFO - mozleak == 0.1 07:01:09 INFO - mozlog == 3.1 07:01:09 INFO - moznetwork == 0.27 07:01:09 INFO - mozprocess == 0.22 07:01:09 INFO - mozprofile == 0.28 07:01:09 INFO - mozrunner == 6.11 07:01:09 INFO - mozscreenshot == 0.1 07:01:09 INFO - mozsystemmonitor == 0.0 07:01:09 INFO - moztest == 0.7 07:01:09 INFO - mozversion == 1.4 07:01:09 INFO - psutil == 3.1.1 07:01:09 INFO - requests == 1.2.3 07:01:09 INFO - wsgiref == 0.1.2 07:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:09 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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:01:09 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 07:01:09 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 07:01:09 INFO - Using env: {'DISPLAY': ':0', 07:01:09 INFO - 'HOME': '/home/cltbld', 07:01:09 INFO - 'LANG': 'en_US.UTF-8', 07:01:09 INFO - 'LANGUAGE': 'en_US:en', 07:01:09 INFO - 'LOGNAME': 'cltbld', 07:01:09 INFO - 'MAIL': '/var/mail/cltbld', 07:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:09 INFO - 'MOZ_NO_REMOTE': '1', 07:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:09 INFO - 'NO_EM_RESTART': '1', 07:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:09 INFO - 'PWD': '/builds/slave/test', 07:01:09 INFO - 'SHELL': '/bin/bash', 07:01:09 INFO - 'SHLVL': '1', 07:01:09 INFO - 'TERM': 'linux', 07:01:09 INFO - 'TMOUT': '86400', 07:01:09 INFO - 'USER': 'cltbld', 07:01:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:09 INFO - '_': '/tools/buildbot/bin/python'} 07:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 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)) 07:01:09 INFO - Cleaning up... 07:01:09 INFO - Return code: 0 07:01:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:09 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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:01:09 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 07:01:09 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 07:01:09 INFO - Using env: {'DISPLAY': ':0', 07:01:09 INFO - 'HOME': '/home/cltbld', 07:01:09 INFO - 'LANG': 'en_US.UTF-8', 07:01:09 INFO - 'LANGUAGE': 'en_US:en', 07:01:09 INFO - 'LOGNAME': 'cltbld', 07:01:09 INFO - 'MAIL': '/var/mail/cltbld', 07:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:09 INFO - 'MOZ_NO_REMOTE': '1', 07:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:09 INFO - 'NO_EM_RESTART': '1', 07:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:09 INFO - 'PWD': '/builds/slave/test', 07:01:09 INFO - 'SHELL': '/bin/bash', 07:01:09 INFO - 'SHLVL': '1', 07:01:09 INFO - 'TERM': 'linux', 07:01:09 INFO - 'TMOUT': '86400', 07:01:09 INFO - 'USER': 'cltbld', 07:01:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:09 INFO - '_': '/tools/buildbot/bin/python'} 07:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:09 INFO - Downloading/unpacking jsonschema 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:01:11 INFO - Downloading/unpacking functools32 (from jsonschema) 07:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:01:11 INFO - warning: no files found matching '*.txt' 07:01:11 INFO - no previously-included directories found matching 'build' 07:01:11 INFO - no previously-included directories found matching 'dist' 07:01:11 INFO - no previously-included directories found matching '.git*' 07:01:11 INFO - Installing collected packages: jsonschema, functools32 07:01:12 INFO - Running setup.py install for functools32 07:01:12 INFO - warning: no files found matching '*.txt' 07:01:12 INFO - no previously-included directories found matching 'build' 07:01:12 INFO - no previously-included directories found matching 'dist' 07:01:12 INFO - no previously-included directories found matching '.git*' 07:01:12 INFO - Successfully installed jsonschema functools32 07:01:12 INFO - Cleaning up... 07:01:12 INFO - Return code: 0 07:01:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:01:12 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')]} 07:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:12 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')]} 07:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:12 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 0x7effa46e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', '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 07:01:12 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 07:01:12 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 07:01:12 INFO - Using env: {'DISPLAY': ':0', 07:01:12 INFO - 'HOME': '/home/cltbld', 07:01:12 INFO - 'LANG': 'en_US.UTF-8', 07:01:12 INFO - 'LANGUAGE': 'en_US:en', 07:01:12 INFO - 'LOGNAME': 'cltbld', 07:01:12 INFO - 'MAIL': '/var/mail/cltbld', 07:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:12 INFO - 'MOZ_NO_REMOTE': '1', 07:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:12 INFO - 'NO_EM_RESTART': '1', 07:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:12 INFO - 'PWD': '/builds/slave/test', 07:01:12 INFO - 'SHELL': '/bin/bash', 07:01:12 INFO - 'SHLVL': '1', 07:01:12 INFO - 'TERM': 'linux', 07:01:12 INFO - 'TMOUT': '86400', 07:01:12 INFO - 'USER': 'cltbld', 07:01:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:12 INFO - '_': '/tools/buildbot/bin/python'} 07:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:12 INFO - Downloading/unpacking flake8 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:01:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:01:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:14 INFO - no previously-included directories found matching 'docs/_build' 07:01:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:01:15 INFO - Running setup.py install for pep8 07:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:15 INFO - no previously-included directories found matching 'docs/_build' 07:01:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:01:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:01:15 INFO - Cleaning up... 07:01:15 INFO - Return code: 0 07:01:15 INFO - Running post-action listener: _resource_record_post_action 07:01:15 INFO - Running post-action listener: _start_resource_monitoring 07:01:15 INFO - Starting resource monitoring. 07:01:15 INFO - ##### 07:01:15 INFO - ##### Running install step. 07:01:15 INFO - ##### 07:01:15 INFO - Running pre-action listener: _resource_record_pre_action 07:01:15 INFO - Running main action method: install 07:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:15 INFO - Reading from file tmpfile_stdout 07:01:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:01:15 INFO - Reading from file tmpfile_stdout 07:01:15 INFO - Output received: 07:01:15 INFO - Usage: mozinstall [options] installer 07:01:15 INFO - Options: 07:01:15 INFO - -h, --help show this help message and exit 07:01:15 INFO - -d DEST, --destination=DEST 07:01:15 INFO - Directory to install application into. [default: 07:01:15 INFO - "/builds/slave/test"] 07:01:15 INFO - --app=APP Application being installed. [default: firefox] 07:01:15 INFO - mkdir: /builds/slave/test/build/application 07:01:15 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'] 07:01:15 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 07:01:31 INFO - Reading from file tmpfile_stdout 07:01:31 INFO - Output received: 07:01:31 INFO - /builds/slave/test/build/application/firefox/firefox 07:01:31 INFO - Running post-action listener: _resource_record_post_action 07:01:31 INFO - ##### 07:01:31 INFO - ##### Running run-tests step. 07:01:31 INFO - ##### 07:01:31 INFO - Running pre-action listener: _resource_record_pre_action 07:01:31 INFO - Running main action method: run_tests 07:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:01:31 INFO - Python 2.7.3 07:01:31 INFO - Return code: 0 07:01:31 INFO - grabbing minidump binary from tooltool 07:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:31 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 0x2850410>, '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 0x2851310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28517a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:01:31 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 07:01:31 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 07:01:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:31 INFO - Return code: 0 07:01:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:01:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:01:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:01:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:01:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:01:32 INFO - Return code: 0 07:01:32 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/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 07:01:32 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/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 07:01:32 INFO - Using env: {'DISPLAY': ':0', 07:01:32 INFO - 'HOME': '/home/cltbld', 07:01:32 INFO - 'LANG': 'en_US.UTF-8', 07:01:32 INFO - 'LANGUAGE': 'en_US:en', 07:01:32 INFO - 'LOGNAME': 'cltbld', 07:01:32 INFO - 'MAIL': '/var/mail/cltbld', 07:01:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:01:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:32 INFO - 'MOZ_NO_REMOTE': '1', 07:01:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:32 INFO - 'NO_EM_RESTART': '1', 07:01:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:32 INFO - 'PWD': '/builds/slave/test', 07:01:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:01:32 INFO - 'SHELL': '/bin/bash', 07:01:32 INFO - 'SHLVL': '1', 07:01:32 INFO - 'TERM': 'linux', 07:01:32 INFO - 'TMOUT': '86400', 07:01:32 INFO - 'USER': 'cltbld', 07:01:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969', 07:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:32 INFO - '_': '/tools/buildbot/bin/python'} 07:01:32 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/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 07:01:32 INFO - mozversion application_buildid: 20160606010529 07:01:32 INFO - mozversion application_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 07:01:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:01:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:32 INFO - mozversion application_name: Firefox 07:01:32 INFO - mozversion application_remotingname: firefox-dev 07:01:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:32 INFO - mozversion application_vendor: Mozilla 07:01:32 INFO - mozversion application_version: 48.0a2 07:01:32 INFO - mozversion platform_buildid: 20160606010529 07:01:32 INFO - mozversion platform_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 07:01:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:32 INFO - mozversion platform_version: 48.0a2 07:01:32 INFO - using testdate: 1465221692 07:01:32 INFO - actual date: 1465221692 07:01:32 INFO - starting webserver on 'localhost:60967' 07:01:32 INFO - SUITE-START | Running 2 tests 07:01:32 INFO - TEST-START | dromaeo_css 07:01:32 INFO - operating with platform_type : linux_ 07:01:32 INFO - Initialising browser for dromaeo_css test... 07:01:32 INFO - TEST-INFO | started process 14840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKwAUY/profile http://localhost:60967/getInfo.html) 07:01:36 INFO - PROCESS | 14840 | 07:01:36 INFO - PROCESS | 14840 | (process:14914): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:01:37 INFO - PROCESS | 14840 | __metrics Screen width/height:1600/1200 07:01:37 INFO - PROCESS | 14840 | colorDepth:24 07:01:37 INFO - PROCESS | 14840 | Browser inner width/height: 1024/697 07:01:37 INFO - PROCESS | 14840 | __metrics 07:01:37 ERROR - PROCESS | 14840 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 07:01:38 INFO - TEST-INFO | 14840: exit 0 07:01:38 INFO - Browser initialized. 07:01:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:38 INFO - TEST-INFO | started process 14965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKwAUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:40 INFO - PROCESS | 14965 | 07:01:40 INFO - PROCESS | 14965 | (process:15031): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:01:50 INFO - PROCESS | 14965 | RSS: Main: 151932928 07:01:50 INFO - PROCESS | 14965 | 07:02:40 INFO - PROCESS | 14965 | 1465221760196 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] 07:04:48 INFO - PROCESS | 14965 | Cycle 1(1): loaded http://localhost:60967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60967/tests/dromaeo/cssquery-ext.html) 07:04:49 INFO - PROCESS | 14965 | RSS: Main: 156536832 07:04:49 INFO - PROCESS | 14965 | 07:07:51 INFO - PROCESS | 14965 | Cycle 1(1): loaded http://localhost:60967/tests/dromaeo/cssquery-ext.html (next: http://localhost:60967/tests/dromaeo/cssquery-jquery.html) 07:07:51 INFO - PROCESS | 14965 | RSS: Main: 153956352 07:07:51 INFO - PROCESS | 14965 | 07:10:53 INFO - PROCESS | 14965 | Cycle 1(1): loaded http://localhost:60967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60967/tests/dromaeo/cssquery-mootools.html) 07:10:53 INFO - PROCESS | 14965 | RSS: Main: 153378816 07:10:53 INFO - PROCESS | 14965 | 07:13:55 INFO - PROCESS | 14965 | Cycle 1(1): loaded http://localhost:60967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60967/tests/dromaeo/cssquery-prototype.html) 07:13:56 INFO - PROCESS | 14965 | RSS: Main: 152866816 07:13:56 INFO - PROCESS | 14965 | 07:16:58 INFO - PROCESS | 14965 | Cycle 1(1): loaded http://localhost:60967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60967/tests/dromaeo/cssquery-yui.html) 07:16:59 INFO - PROCESS | 14965 | RSS: Main: 154693632 07:16:59 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | Cycle 1(1): loaded http://localhost:60967/tests/dromaeo/cssquery-yui.html (next: http://localhost:60967/tests/dromaeo/cssquery-dojo.html) 07:20:01 INFO - PROCESS | 14965 | RSS: Main: 156213248 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | __start_tp_report 07:20:01 INFO - PROCESS | 14965 | _x_x_mozilla_page_load 07:20:01 INFO - PROCESS | 14965 | _x_x_mozilla_page_load_details 07:20:01 INFO - PROCESS | 14965 | |i|pagename|runs| 07:20:01 INFO - PROCESS | 14965 | |0;dojo.html;3401.2857299967004;3450.551428314319;3468.167639766456;3481.982590087049;3493.248951475434;5746.798862039829;5802.12968054792;5815.069588865772;5823.796167134151;5824.563157763168;5785.884282314361;5819.534437245021;5841.269841269841;5852.414758524156;5854.531637469003;5232.529072383485;5235.162374020158;5278.181881808326;5304.257403963448;5309.230161626562;5184.688918664892;5329.25390445338;5375.3280839895015;5406.783728650849;5436.728163591824;5255.0803609368395;5316.4683531646715;5339.706316152629;5341.519263266306;5352.277442545265;5290.7354632268425;5345.705986170759;5347;5348.331458567679;5348.358197016344;5216.035033518811;5264.105102132608;5287.41838397776;5298.125809241471;5306.151015837448;5532.612717109804;5600.187972743929;5699.202111704365;5704.686242256675;5729.598928075036;6193.566450348478;6229.065640153968;6235.376462353728;6242.282137554194;6258.749650013994;6294.118823364733;6300.117983482316;6300.5589608727405;6303.117563541108;6305.8108256752375;5676.460736230051;5787.1608616750755;5808.361080281165;5872.559558033165;5875.706214689291;6285.465735412449;6326.905096423558;6336.746530138835;6342.080398342215;6359.872802543923;6045.0327947528185;6053.061775424816;6076.726547305382;6105.419985101408;6111.205543279434;6206.689665516797;6279.591826531261;6279.843003924939;6298.559100862895;6317.46301564363;6100;6116.48009919153;6130.141780150782;6130.908036379458;6135.570510064342;6075.513958883279;6115.388461153849;6133.264008318941;6136.2636483622255;6139.171211886338;4661.790219440133;4665.906681866344;4682.882927926829;4711;4718.245080787057;4200.642945349679;4203.138356636943;4222.0289333453475;4229.851955181553;4253.510846252659;5829.5044921181325;6033.879322413527;6038.154658347835;6042.818715438544;6043.2748070231855;6049.546284028627;6140.95603747364;6143.38566143391;6245.531585131133;6261.5616906816085;5875.265591801025;5888.941110588925;5896.7936122235515;5918.970405148033;5966.880662386728;5153.098207813618;5295.285136506523;5296.152615581565;5307.150855863043;5310.893782124336;6353.714082866282;6360.6501642409185;6399.616023038632;6511.804645860631;6554.180727409074;6206.441420272197;6228.750849965951;6285.874282514233;6291.213598300213;6291.622502649856;6467.062275970052;6480.902786458113;6484.221893372825;6486.318936511787;6502.349765023459;6004.519638428827;6102.694865256631;6197.81406557804;6218.595791273553;6239.438450539473;6114.480269176992;6171.13604095418;6179.351168127461;6180.258368995749;6185.938140618716;5912.408759124053;5954.880902382015;5957.821265362046;6005.249343832021;6022.54830887694;5909.52723782105;5960.046392577166;6005.279366476051;6008.489278411384;6012.488938440107;5911.408859114054;5987.670678112571;6014.6391216527145;6019.398060193946;6022.337542870368;5978.312494063239;6040.516758659209;6112.755489780359;6127.632342059491;6160.476359509492;6036.849078773066;6043.09353596964;6044.879102418015;6047.455728984412;6084.361142080018 07:20:01 INFO - PROCESS | 14965 | |1;ext.html;637.1653134393945;659.2517492645846;669.4711178169243;676.7969609117265;697.8325201951527;37330.81334593327;37825.43261851074;38194;38286.42570361447;38319.616803832025;39113.60886391135;39256.41115383265;39778.204435911335;39871;39881.40177897334;8622.353323500747;8769.561521923879;8841.513716745576;8861.778455538599;8872.37893347466;8730.301575873915;8981.416207946495;9036.50299233542;9118.589663465127;9125.863112053325;8989.41568798026;9027.819443611124;9059.682911098113;9082.54587270637;9099;8992.055834137453;8993.955030224839;9052.411593246417;9065.954670226673;9073.364864459458;8772.912270877338;8874.112588741074;8923;8935.061818509028;8966.686165984225;38795.41806872899;39415.40876886849;39662.801685991384;39693;39745;3872.206197729487;3890.474785903895;3915.099527108752;4035.2131334389805;4115.629593336614;32069;32147.51778723321;32188.356232875445;32400.513992290136;32512.512312315335;4557.95442045582;4614.330922016323;4689.554492323224;4695.272232803921;4722.409698787652;333143;333479;333801;334165;334230;60414.69792651009;60576.69711651414;60726.39273607296;60858;60977.69511152416;67862.30344241434;68009.31990680129;68207.3179268211;68342;68477.65761171162;17883;18000.549986250448;18394.356197533023;18528.629427411644;18683.439496815117;14542.636434089232;14588.489402870848;14595.197264150362;14615.196164211071;14617.78073328901;19347.00364330593;19436.61126777485;20255.29106481266;20431;20468.38594842157;7292.8176795579475;7421.517601355895;7472.17806041335;7625.771226863203;7684.193159718149;1093.3494570730402;1155.2548606148987;1158.25871442277;1176.4117941029485;1193.8360098903672;32038.35923281521;32388.190295242806;32778.344433111204;32893;33261.50107748386;1215.9027277817754;1219.9878001220052;1259.212991880075;1302.66476861218;1310.4758096761373;17290.827091728923;17526.64946701059;17536.47390578285;17549.385771497935;17646.558836029202;485397;525572;839145;856322;860699;60762.088568671505;61549;61797;61972.38027619666;62288.37711622826;1540.7688846673088;1562.0237351655217;1562.6093476630842;1571.3871590079877;1579.494561740232;33140.337193256484;33295.50056749199;33493;33538.83230583832;34077.82961085179;52721;53543.46456535385;53585.19622205748;53644.73177634087;53736.73131634317;452295;453350;453543;455772;456844;30282.54576181315;30410.39179216359;30626.84686576553;30798;30859.228519287197;47896.28155577739;48031.279530806365;48352;49044.2643360357;49563.25655115104;42450.36324455074;42591;42600.360994585724;43189.13621727611;46507;39246.41130383104;39473.80263098666;39535.80232098936;39942.2011559773;40887.77336679905;40174;41104.794476027426;41266.58733412628;41565.79217103895;42239.15521689488;35484.88586367576;35512.644873551966;35823.64176358203;36126.63873361233;36346.63653363432;28444.85777571099;28807.5678864813;28831.423371532033;28839.42321153523;29303 07:20:01 INFO - PROCESS | 14965 | |2;jquery.html;414.3701573608115;419.8383622305411;424.72180721627325;431.85316992222636;432.19395826783057;18534.536636584093;19228.327008554705;19249.711254331196;19318;19886.60226795467;19503.902480487614;19836.9008154959;20209.191632334725;20708.8964555177;20738.859362735082;5664.0937450007905;5752.194692743019;5899.734511946951;5910.379410161936;5942.049272116462;5812.099124635667;5855.092460668603;5866.6480011199255;5886.941130588682;5888.735006924678;5650.124230744241;5738.254026976487;5738.3974682658345;5890.116482527612;5905.645661260338;5774.047282198453;5819.476247137757;5826.21346118275;5834.095715164156;5844.211031510734;5082.771275292621;5249.002689488985;5254.816081437131;5346.251524786533;5364.436734142898;23476.413089672897;23669;23874.164404245766;23882.880585596962;23935.640965385533;2447.9388015299583;2737.0693964052316;2892.4359749848786;2993.655729591103;3310.2882880180637;14597.708045839025;14941.252937353089;15071.397144114222;15171.089734615958;15361.539153825403;1914.5979344337707;1937.3703546347353;1996.2414282572674;2040.1533363654066;2057.6501994660794;77651;78461;78679;79448;80033.59983200105;10966.342019478856;10971.83542246867;11333;11341.659750207507;11566.826497602542;15365.154916479702;15494.225288735519;15579.298931548108;15677;15690.215489225722;8972.102789720975;9065.274778017743;9065.77335566616;9226;9233.907660923305;9075.682351117679;9172.633094676272;9226.26189904806;9311.068893110634;9381.0618938107;6851.931480685229;6903.861922761516;6953.200381956039;7004.824879377954;7065.964670176616;1964.3026725512236;1985.2852972929734;2002.8883969396834;2020.6867935470025;2028.705837653532;1056.7675111475462;1116.1071143085499;1152.1992215410378;1174.7121955120879;1204.5362535423924;16794.58013549671;19953.102110405067;20196.79803201949;20282.594348112954;20418;1135.7047167736448;1141.041525118904;1151.234429104636;1164.295601161302;1183.71590818203;11385.544578216779;11708.414579271002;11738.413079345999;11747.941260293645;11836.526538938346;454081;461891;463724;466503;468093;49344.50655493399;76637;76818.23181768223;77611.61194193993;79786;1120.0479592346603;1136.5567428702811;1138.5502726423017;1138.59579849154;1156.6934762288001;17249.39627113095;17698.469045928643;17743.378981736092;17945;17994;37429.43855842219;37649.24701506009;37795.81102094582;38017.2396552073;38623.806880965414;51650;52556;53118;53629.19556206738;53713.46286537241;9022.729318120468;9167.404118732262;9240.802692210273;9310.394824336396;9346.112119348923;14073.155610663393;14105;14153.787693184404;14195.64510887236;14537.127772333693;11858.34779087124;12052.216605920587;12135.817962730744;12336.691582710504;12836.55072072473;11626.430431891924;12042.277463352228;12209.69475763113;12518.812217816558;12522.311272880079;11825.52697892109;12258.264504129424;12397.690057748629;12696;12948.15836970594;8516.531590762319;8568.828623427622;8799.868001980103;9044.81910361776;9276.443413395218;9995.650152244636;10638.255322127687;10670.46647667629;10763.677089687322;10830.133589312678 07:20:01 INFO - PROCESS | 14965 | |3;mootools.html;1547.6904619076186;1567.843215678432;1725.0684630299638;1811.5923917118657;1816.445983974888;7875.8424831503335;8564;8661.913380866197;8859.379843410956;8869.46783193008;8624.741257762262;8675.349348798834;8755.080716524753;8759.649614015432;8766.868496972551;2432.075811191749;2437.402836305099;2445.572024895645;2455.2388759484616;2459.225344016629;2405.1461731085474;2428.732839387666;2429.0648100481353;2434.318390850565;2439.609662454008;2416.2751174647624;2425.8301918865686;2435.2450740270483;2443.218170185541;2459.397447625325;2433.7201221859536;2434.7808697217247;2459.631055341713;2466.642336861154;2470.1601455505124;2411.7588241175918;2430.5989511730545;2431.8662473563945;2435.768601982809;2439.6828412306463;8980.910190898072;9010.45937243761;9036.412633178888;9057.818843623156;9058.682946096855;5352.223927530486;5471.7264136793;5483.917741233885;5486.670799751988;5506.504414602665;3465.6361082086523;3529.6470352964757;3577.3739595570933;3605.441156620702;3619.6561326673923;1152.9654110376619;1161.6863446869297;1178.7053236690826;1206.2400687566865;1210.8910198082215;12465.252084874937;12475.875241247653;12622.305773182472;12622.431990560446;12667.683307917283;4692.967547139624;4695.436547614308;4783.234682450791;4811.78346974387;4817.253325734517;10580.682579522627;10588.947055264674;10695.197860160519;10729.570817167227;10735.248532602798;5394.460553944653;5449.346078470529;5471.863203419946;5473.67157970523;5475.808346707846;4449.2658711312915;4941.802327906916;4985.725785081855;5034.546890779848;5071.2139618359215;4215.220184265921;4238.766867822238;4271.060366719316;4323.935140972888;4326.848560300375;1381.109184575943;1392.9024968252327;1396.7974643676814;1419.198153043527;1420.708754705283;1090.5910283643634;1093.3822390349585;1098.7143342730787;1102.459794700591;1104.9668509944715;6190.473809726133;6314.210723659543;6379.649119298483;6392.584482008655;6531.183602049744;482.93721816163674;486.3021564055592;490.7865078690781;492.6305271046715;499.24115344676613;4389.100234451929;4398.494173170063;4437.622802061796;4452.710573812692;4469.262571675637;10915.072218861485;11126.944365278121;11196.720081998015;11256.324620522795;11259.887401125883;10818.621348252931;11010.834837477445;11098.889011109946;11221.495032723547;11230.438478076063;8545.957270213734;8639.13608639131;8670.739877803677;8686.391952563386;8721.215090641872;6037.78867739627;6121.173641558511;6125.387461253839;6223.066540019034;6250.031245157008;9626.326157169211;9853.06395892389;9873.160781333667;9875.851862222216;10160.034796694303;10046.69859904204;10100.141487973604;10148.543315550965;10230.641927532799;10240.539175737258;7674.846503069795;7840.176781438095;7897.763067107996;8081.030276366873;8162.469439486415;8303.04514980785;8324.0427350853;8347.457415267989;8427.915720842713;8458.196471335214;7466.141393739789;7685.03937007874;7733.690652374067;7778.0666320041955;7799.727009554638;7191.42468602521;7322.414206863545;7371.668274927534;7394.926050739424;7428;7226.638668066681;7230.710771569078;7267.890981635174;7318.926810731825;7323.340899319087;5326.707031113326;5332.440093790251;5390.784368625211;5443.992861320668;5496.615236933376;5295.073362161529;5295.814646487354;5296.417394086724;5309.178647630007;5341.75962081715 07:20:01 INFO - PROCESS | 14965 | |4;prototype.html;355.445505012181;369.07178446207786;372.4264632466002;378.7178551978776;379.7987066854568;6491.383318584739;6644.402003819661;6675.699593518291;6751.797446076619;6772.2889096644885;6646.302138275484;6654.667266636661;6657;6682.398584127428;6695.866082678343;5025.321581586476;5060.671056381342;5062.974685126569;5072.26452164436;5081.034603425356;5071.1632580624155;5077.121465057934;5081.7459127043685;5081.898362032775;5083.949160508385;5022.598192144638;5024.171011783052;5027.2207807789855;5030.798768049273;5047.0915235257635;4938.728369939652;5001.124803159432;5014.648974571782;5022.673526220784;5051.343325367716;4374.278244089754;4391.9020244938765;4393.055493069006;4409.889752756175;4412.669049821244;6404.167458230447;6426.325235850262;6432.5497215194955;6436;6448.613083215022;5868.09044598088;5917.467427931464;5924.4667979882015;5929.881402371929;5934.970325148347;7047.859042819115;7048.259932707095;7050.858982820315;7057.329553692391;7071.222165561784;4613.238815595423;4756.762161891892;4762.309465127537;4922.532359425849;4929.7781599828095;7201.243869393743;7296.087989001375;7317.926820731831;7338.669759860819;7355.779326620156;4868.318435419044;4869.9513004870205;4870.6103511718975;4874.390701162355;4874.4150701916;4917.827876024322;4919.409670839451;4930.9506904930495;4934.950650493521;4954.727489988085;5760.711964401763;5764;5773.855653608609;5781.277340332458;5788.855278617984;6939.93060069403;7035.859282814315;7048.823779405556;7062.71749130029;7062.894056589155;1715.2881554155135;1736.9913150434168;1738.2959901239765;1745.424010076697;1751.3082332478855;1118.072000239799;1119.7144728094283;1134.387430787382;1148.6496618531262;1150.1891166727437;6826.180858296937;6841.418479429304;6864.450843932474;6870.862582748317;6890.552114112566;7213.8557228855125;7216.639168041577;7221.711131554784;7271.127464704269;7301.2333704961275;6789;6853.965730171317;6858.245592984767;6860.416864566568;6871.931280687129;3849.2301539692176;3875.5736868944396;3891.669208117285;3922.7450215736458;3927.489426374553;7459.3286604204795;7530.736424225126;7569.091708994956;7588.582627955516;7602.50583712057;7323.414126869838;7328.120625524864;7346.853062938711;7348.448866335047;7379.6679149438405;7521.586312752742;7531.623418829036;7542.434317426215;7547.320741133434;7563.470557061063;6951.131108611424;7139.964300178466;7172.354488095888;7175.425965922609;7229;7088.468364872552;7094.574325540484;7103.9289607103265;7105.75129870452;7110;7526.736564220226;7535.171131175457;7545.283198096172;7549.471536992577;7567.962160189164;4865.416150062015;4866.489018653132;4867.367242258484;4876.536729010738;4898.8775280618265;7056.223815380202;7163.6060016699585;7170.928290717026;7203.207647158703;7206.6396680164735;6943.993120997326;6978.267281935324;7041.3310735480045;7082.929170708433;7106;7032.964835175996;7084.752033678797;7090.255523169993;7104;7120.893186602101;6923.861522769415;6945.992831039572;6950.8609827804175;6957.1651401832105;6971.965140174267;6996.545224560387;7091.290870912868;7163.964180179066;7169.247229040876;7189.209186989322;6852.349026842442;6964.9900764389895;6982.685779140053;6984.092068031124;7006.334398232159 07:20:01 INFO - PROCESS | 14965 | |5;yui.html;907.9273658107352;918.1552971266439;920.3925409229907;921.9769505762355;942.4722155592864;14353.354099065527;14427.927860360696;14574.56276311711;14926.104433733983;14973;13859.307034648253;13881.09772864763;13884.444622215124;13897.166170029805;13919.582412527616;874.921257086862;885.9943963601327;892.0455113029029;892.1524551675934;892.6607889002203;880.1726377205406;898.3307435960186;918.6555041859302;922.5018490015384;922.7646950027768;936.5130132331184;944.2351695126969;946.9715908522755;949.8432758594823;950.8145911547251;936.3118108190474;941.1952780372785;943.3443756589173;943.4716558727134;945.8675785390051;691.0360047733434;692.7679227458807;693.386353077525;694.0144994108379;694.2190036209265;15056.774148387783;15089.622759430993;15096.094234345974;15100.697986040328;15102.471413500474;13614.591562253148;13655.863441365558;13788;14029.088109272865;14312.42750289987;11999.400029998465;12016;12047.57833475833;12092.093093018058;12177.756444871053;3964.1278918637854;4002.3596224603925;4027.416024676435;4047.919041619151;4094.7338423002707;57478.137827932616;57907.71046144742;58207.70896145535;58257.70871145617;58275.708621457045;10147.543360548792;10367.222458315657;10445.216608754374;10563.894361056291;10586.20603454744;18962.051897405076;19045.80954190468;19074.14166362517;19082.52293692641;19101.331453399063;8233.423660343838;8318.8336233275;8332.04181519133;8549.871751923725;8813.383063185644;4795.592374648124;4883.804647814119;4899.6570240083565;4933.679310844784;4982.177940639826;3635.9091022724115;3675.46705727668;3679.5400574928135;3697.7781333120097;3704.036950392863;564.5963136357442;627.5230824573357;632.3076231526471;635.7997230872261;636.2746469025315;689.8689249042666;770.6228621430218;781.0588241169377;790.9367250619937;794.8450052239873;10183.083522483012;10351.378917264989;10450.477476126163;10465.738356541147;10605.257631965842;733.2777214443769;789.289639324601;797.3063434811635;814.3851392198852;821.9766390843319;4537.09258148365;4579.95420045802;4726.338312636233;4780.976095119572;4800.255960326155;65119.67440162864;66453.66773166103;66513;66550;66772.3322766766;54444.183337249975;55921.72039139778;56477.43522564804;56888.71555642195;57597.42402576005;50902.23646645303;51734.482655172964;52368;52939.73530132325;52953.7352313236;9434.95282523583;9446.480443575669;9494.620215191591;9600.807983840145;9623.470709111067;38796;39362;39649.20701585894;39654.603453965094;39865;46938.530614693416;49875.50124498854;50159;50348.196029615465;50801.49198507968;11195.496202671062;11327.433628318717;11433.142514311627;11484.081273497934;11525.654230372767;12665.683357916127;12667.17663351916;13091.934540327238;13208.603741887759;13332.533361332307;11592.6522204334;11756.470958807045;11833.230839995716;11845.644630661094;12053.939730301643;11802.76394472123;11872;12021.45903434365;12216.938915305722;12368.134230603771;11313.490892910004;11507.654770356903;11509.194356394972;11640.476178572155;11980.341081240615;10184.694459166238;10379.273450858367;10406.947965260428;10428;10648.520816563429;10125;10627.309224900666;10669.839952400875;10696.679099627023;10730.89269107299 07:20:01 INFO - PROCESS | 14965 | __end_tp_report 07:20:01 INFO - PROCESS | 14965 | __start_cc_report 07:20:01 INFO - PROCESS | 14965 | _x_x_mozilla_cycle_collect,321 07:20:01 INFO - PROCESS | 14965 | __end_cc_report 07:20:01 INFO - PROCESS | 14965 | __startTimestamp1465222801555__endTimestamp 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | ------- Summary: start ------- 07:20:01 INFO - PROCESS | 14965 | Number of tests: 6 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | [#0] dojo.html Cycles:165 Average:5769.48 Median:6008.49 stddev:647.63 (10.8%) stddev-sans-first:622.40 07:20:01 INFO - PROCESS | 14965 | Values: 3401.3 3450.6 3468.2 3482.0 3493.2 5746.8 5802.1 5815.1 5823.8 5824.6 5785.9 5819.5 5841.3 5852.4 5854.5 5232.5 5235.2 5278.2 5304.3 5309.2 5184.7 5329.3 5375.3 5406.8 5436.7 5255.1 5316.5 5339.7 5341.5 5352.3 5290.7 5345.7 5347.0 5348.3 5348.4 5216.0 5264.1 5287.4 5298.1 5306.2 5532.6 5600.2 5699.2 5704.7 5729.6 6193.6 6229.1 6235.4 6242.3 6258.7 6294.1 6300.1 6300.6 6303.1 6305.8 5676.5 5787.2 5808.4 5872.6 5875.7 6285.5 6326.9 6336.7 6342.1 6359.9 6045.0 6053.1 6076.7 6105.4 6111.2 6206.7 6279.6 6279.8 6298.6 6317.5 6100.0 6116.5 6130.1 6130.9 6135.6 6075.5 6115.4 6133.3 6136.3 6139.2 4661.8 4665.9 4682.9 4711.0 4718.2 4200.6 4203.1 4222.0 4229.9 4253.5 5829.5 6033.9 6038.2 6042.8 6043.3 6049.5 6141.0 6143.4 6245.5 6261.6 5875.3 5888.9 5896.8 5919.0 5966.9 5153.1 5295.3 5296.2 5307.2 5310.9 6353.7 6360.7 6399.6 6511.8 6554.2 6206.4 6228.8 6285.9 6291.2 6291.6 6467.1 6480.9 6484.2 6486.3 6502.3 6004.5 6102.7 6197.8 6218.6 6239.4 6114.5 6171.1 6179.4 6180.3 6185.9 5912.4 5954.9 5957.8 6005.2 6022.5 5909.5 5960.0 6005.3 6008.5 6012.5 5911.4 5987.7 6014.6 6019.4 6022.3 5978.3 6040.5 6112.8 6127.6 6160.5 6036.8 6043.1 6044.9 6047.5 6084.4 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | [#1] ext.html Cycles:180 Average:65705.62 Median:39911.80 stddev:143342.69 (359.1%) stddev-sans-first:143661.55 07:20:01 INFO - PROCESS | 14965 | Values: 637.2 659.3 669.5 676.8 697.8 37330.8 37825.4 38194.0 38286.4 38319.6 39113.6 39256.4 39778.2 39871.0 39881.4 8622.4 8769.6 8841.5 8861.8 8872.4 8730.3 8981.4 9036.5 9118.6 9125.9 8989.4 9027.8 9059.7 9082.5 9099.0 8992.1 8994.0 9052.4 9066.0 9073.4 8772.9 8874.1 8923.0 8935.1 8966.7 38795.4 39415.4 39662.8 39693.0 39745.0 3872.2 3890.5 3915.1 4035.2 4115.6 32069.0 32147.5 32188.4 32400.5 32512.5 4558.0 4614.3 4689.6 4695.3 4722.4 333143.0 333479.0 333801.0 334165.0 334230.0 60414.7 60576.7 60726.4 60858.0 60977.7 67862.3 68009.3 68207.3 68342.0 68477.7 17883.0 18000.5 18394.4 18528.6 18683.4 14542.6 14588.5 14595.2 14615.2 14617.8 19347.0 19436.6 20255.3 20431.0 20468.4 7292.8 7421.5 7472.2 7625.8 7684.2 1093.3 1155.3 1158.3 1176.4 1193.8 32038.4 32388.2 32778.3 32893.0 33261.5 1215.9 1220.0 1259.2 1302.7 1310.5 17290.8 17526.6 17536.5 17549.4 17646.6 485397.0 525572.0 839145.0 856322.0 860699.0 60762.1 61549.0 61797.0 61972.4 62288.4 1540.8 1562.0 1562.6 1571.4 1579.5 33140.3 33295.5 33493.0 33538.8 34077.8 52721.0 53543.5 53585.2 53644.7 53736.7 452295.0 453350.0 453543.0 455772.0 456844.0 30282.5 30410.4 30626.8 30798.0 30859.2 47896.3 48031.3 48352.0 49044.3 49563.3 42450.4 42591.0 42600.4 43189.1 46507.0 39246.4 39473.8 39535.8 39942.2 40887.8 40174.0 41104.8 41266.6 41565.8 42239.2 35484.9 35512.6 35823.6 36126.6 36346.6 28444.9 28807.6 28831.4 28839.4 29303.0 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | [#2] jquery.html Cycles:180 Average:27857.04 Median:23771.58 stddev:75894.31 (319.3%) stddev-sans-first:76079.24 07:20:01 INFO - PROCESS | 14965 | Values: 414.4 419.8 424.7 431.9 432.2 18534.5 19228.3 19249.7 19318.0 19886.6 19503.9 19836.9 20209.2 20708.9 20738.9 5664.1 5752.2 5899.7 5910.4 5942.0 5812.1 5855.1 5866.6 5886.9 5888.7 5650.1 5738.3 5738.4 5890.1 5905.6 5774.0 5819.5 5826.2 5834.1 5844.2 5082.8 5249.0 5254.8 5346.3 5364.4 23476.4 23669.0 23874.2 23882.9 23935.6 2447.9 2737.1 2892.4 2993.7 3310.3 14597.7 14941.3 15071.4 15171.1 15361.5 1914.6 1937.4 1996.2 2040.2 2057.7 77651.0 78461.0 78679.0 79448.0 80033.6 10966.3 10971.8 11333.0 11341.7 11566.8 15365.2 15494.2 15579.3 15677.0 15690.2 8972.1 9065.3 9065.8 9226.0 9233.9 9075.7 9172.6 9226.3 9311.1 9381.1 6851.9 6903.9 6953.2 7004.8 7066.0 1964.3 1985.3 2002.9 2020.7 2028.7 1056.8 1116.1 1152.2 1174.7 1204.5 16794.6 19953.1 20196.8 20282.6 20418.0 1135.7 1141.0 1151.2 1164.3 1183.7 11385.5 11708.4 11738.4 11747.9 11836.5 454081.0 461891.0 463724.0 466503.0 468093.0 49344.5 76637.0 76818.2 77611.6 79786.0 1120.0 1136.6 1138.6 1138.6 1156.7 17249.4 17698.5 17743.4 17945.0 17994.0 37429.4 37649.2 37795.8 38017.2 38623.8 51650.0 52556.0 53118.0 53629.2 53713.5 9022.7 9167.4 9240.8 9310.4 9346.1 14073.2 14105.0 14153.8 14195.6 14537.1 11858.3 12052.2 12135.8 12336.7 12836.6 11626.4 12042.3 12209.7 12518.8 12522.3 11825.5 12258.3 12397.7 12696.0 12948.2 8516.5 8568.8 8799.9 9044.8 9276.4 9995.7 10638.3 10670.5 10763.7 10830.1 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | [#3] mootools.html Cycles:180 Average:5921.70 Median:4814.52 stddev:3308.85 (68.7%) stddev-sans-first:3301.81 07:20:01 INFO - PROCESS | 14965 | Values: 1547.7 1567.8 1725.1 1811.6 1816.4 7875.8 8564.0 8661.9 8859.4 8869.5 8624.7 8675.3 8755.1 8759.6 8766.9 2432.1 2437.4 2445.6 2455.2 2459.2 2405.1 2428.7 2429.1 2434.3 2439.6 2416.3 2425.8 2435.2 2443.2 2459.4 2433.7 2434.8 2459.6 2466.6 2470.2 2411.8 2430.6 2431.9 2435.8 2439.7 8980.9 9010.5 9036.4 9057.8 9058.7 5352.2 5471.7 5483.9 5486.7 5506.5 3465.6 3529.6 3577.4 3605.4 3619.7 1153.0 1161.7 1178.7 1206.2 1210.9 12465.3 12475.9 12622.3 12622.4 12667.7 4693.0 4695.4 4783.2 4811.8 4817.3 10580.7 10588.9 10695.2 10729.6 10735.2 5394.5 5449.3 5471.9 5473.7 5475.8 4449.3 4941.8 4985.7 5034.5 5071.2 4215.2 4238.8 4271.1 4323.9 4326.8 1381.1 1392.9 1396.8 1419.2 1420.7 1090.6 1093.4 1098.7 1102.5 1105.0 6190.5 6314.2 6379.6 6392.6 6531.2 482.9 486.3 490.8 492.6 499.2 4389.1 4398.5 4437.6 4452.7 4469.3 10915.1 11126.9 11196.7 11256.3 11259.9 10818.6 11010.8 11098.9 11221.5 11230.4 8546.0 8639.1 8670.7 8686.4 8721.2 6037.8 6121.2 6125.4 6223.1 6250.0 9626.3 9853.1 9873.2 9875.9 10160.0 10046.7 10100.1 10148.5 10230.6 10240.5 7674.8 7840.2 7897.8 8081.0 8162.5 8303.0 8324.0 8347.5 8427.9 8458.2 7466.1 7685.0 7733.7 7778.1 7799.7 7191.4 7322.4 7371.7 7394.9 7428.0 7226.6 7230.7 7267.9 7318.9 7323.3 5326.7 5332.4 5390.8 5444.0 5496.6 5295.1 5295.8 5296.4 5309.2 5341.8 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | [#4] prototype.html Cycles:180 Average:5874.89 Median:6807.59 stddev:1792.08 (26.3%) stddev-sans-first:1748.57 07:20:01 INFO - PROCESS | 14965 | Values: 355.4 369.1 372.4 378.7 379.8 6491.4 6644.4 6675.7 6751.8 6772.3 6646.3 6654.7 6657.0 6682.4 6695.9 5025.3 5060.7 5063.0 5072.3 5081.0 5071.2 5077.1 5081.7 5081.9 5083.9 5022.6 5024.2 5027.2 5030.8 5047.1 4938.7 5001.1 5014.6 5022.7 5051.3 4374.3 4391.9 4393.1 4409.9 4412.7 6404.2 6426.3 6432.5 6436.0 6448.6 5868.1 5917.5 5924.5 5929.9 5935.0 7047.9 7048.3 7050.9 7057.3 7071.2 4613.2 4756.8 4762.3 4922.5 4929.8 7201.2 7296.1 7317.9 7338.7 7355.8 4868.3 4870.0 4870.6 4874.4 4874.4 4917.8 4919.4 4931.0 4935.0 4954.7 5760.7 5764.0 5773.9 5781.3 5788.9 6939.9 7035.9 7048.8 7062.7 7062.9 1715.3 1737.0 1738.3 1745.4 1751.3 1118.1 1119.7 1134.4 1148.6 1150.2 6826.2 6841.4 6864.5 6870.9 6890.6 7213.9 7216.6 7221.7 7271.1 7301.2 6789.0 6854.0 6858.2 6860.4 6871.9 3849.2 3875.6 3891.7 3922.7 3927.5 7459.3 7530.7 7569.1 7588.6 7602.5 7323.4 7328.1 7346.9 7348.4 7379.7 7521.6 7531.6 7542.4 7547.3 7563.5 6951.1 7140.0 7172.4 7175.4 7229.0 7088.5 7094.6 7103.9 7105.8 7110.0 7526.7 7535.2 7545.3 7549.5 7568.0 4865.4 4866.5 4867.4 4876.5 4898.9 7056.2 7163.6 7170.9 7203.2 7206.6 6944.0 6978.3 7041.3 7082.9 7106.0 7033.0 7084.8 7090.3 7104.0 7120.9 6923.9 6946.0 6950.9 6957.2 6972.0 6996.5 7091.3 7164.0 7169.2 7189.2 6852.3 6965.0 6982.7 6984.1 7006.3 07:20:01 INFO - PROCESS | 14965 | 07:20:01 INFO - PROCESS | 14965 | [#5] yui.html Cycles:180 Average:15412.97 Median:4558.52 stddev:18198.98 (399.2%) stddev-sans-first:18217.44 07:20:01 INFO - PROCESS | 14965 | Values: 907.9 918.2 920.4 922.0 942.5 14353.4 14427.9 14574.6 14926.1 14973.0 13859.3 13881.1 13884.4 13897.2 13919.6 874.9 886.0 892.0 892.2 892.7 880.2 898.3 918.7 922.5 922.8 936.5 944.2 947.0 949.8 950.8 936.3 941.2 943.3 943.5 945.9 691.0 692.8 693.4 694.0 694.2 15056.8 15089.6 15096.1 15100.7 15102.5 13614.6 13655.9 13788.0 14029.1 14312.4 11999.4 12016.0 12047.6 12092.1 12177.8 3964.1 4002.4 4027.4 4047.9 4094.7 57478.1 57907.7 58207.7 58257.7 58275.7 10147.5 10367.2 10445.2 10563.9 10586.2 18962.1 19045.8 19074.1 19082.5 19101.3 8233.4 8318.8 8332.0 8549.9 8813.4 4795.6 4883.8 4899.7 4933.7 4982.2 3635.9 3675.5 3679.5 3697.8 3704.0 564.6 627.5 632.3 635.8 636.3 689.9 770.6 781.1 790.9 794.8 10183.1 10351.4 10450.5 10465.7 10605.3 733.3 789.3 797.3 814.4 822.0 4537.1 4580.0 4726.3 4781.0 4800.3 65119.7 66453.7 66513.0 66550.0 66772.3 54444.2 55921.7 56477.4 56888.7 57597.4 50902.2 51734.5 52368.0 52939.7 52953.7 9435.0 9446.5 9494.6 9600.8 9623.5 38796.0 39362.0 39649.2 39654.6 39865.0 46938.5 49875.5 50159.0 50348.2 50801.5 11195.5 11327.4 11433.1 11484.1 11525.7 12665.7 12667.2 13091.9 13208.6 13332.5 11592.7 11756.5 11833.2 11845.6 12053.9 11802.8 11872.0 12021.5 12216.9 12368.1 11313.5 11507.7 11509.2 11640.5 11980.3 10184.7 10379.3 10406.9 10428.0 10648.5 10125.0 10627.3 10669.8 10696.7 10730.9 07:20:01 INFO - PROCESS | 14965 | -------- Summary: end -------- 07:20:01 INFO - PROCESS | 14965 | 07:20:02 INFO - TEST-INFO | 14965: exit 0 07:20:02 INFO - TEST-OK | dromaeo_css | took 1109843ms 07:20:02 INFO - TEST-START | kraken 07:20:02 INFO - operating with platform_type : linux_ 07:20:02 INFO - Initialising browser for kraken test... 07:20:02 INFO - TEST-INFO | started process 15208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNplSjU/profile http://localhost:60967/getInfo.html) 07:20:06 INFO - PROCESS | 15208 | 07:20:06 INFO - PROCESS | 15208 | (process:15283): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:20:06 INFO - PROCESS | 15208 | __metrics Screen width/height:1600/1200 07:20:06 INFO - PROCESS | 15208 | colorDepth:24 07:20:06 INFO - PROCESS | 15208 | Browser inner width/height: 1024/697 07:20:06 INFO - PROCESS | 15208 | __metrics 07:20:07 ERROR - PROCESS | 15208 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 07:20:08 INFO - TEST-INFO | 15208: exit 0 07:20:08 INFO - Browser initialized. 07:20:08 INFO - Running cycle 1/1 for kraken test... 07:20:08 INFO - TEST-INFO | started process 15334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNplSjU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:10 INFO - PROCESS | 15334 | 07:20:10 INFO - PROCESS | 15334 | (process:15401): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:20:20 INFO - PROCESS | 15334 | RSS: Main: 151834624 07:20:20 INFO - PROCESS | 15334 | 07:20:22 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60967/tests/kraken/driver.html?testName=audio-beat-detection) 07:20:23 INFO - PROCESS | 15334 | RSS: Main: 156913664 07:20:23 INFO - PROCESS | 15334 | 07:20:26 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60967/tests/kraken/driver.html?testName=audio-dft) 07:20:26 INFO - PROCESS | 15334 | RSS: Main: 157036544 07:20:26 INFO - PROCESS | 15334 | 07:20:29 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60967/tests/kraken/driver.html?testName=audio-fft) 07:20:30 INFO - PROCESS | 15334 | RSS: Main: 157339648 07:20:30 INFO - PROCESS | 15334 | 07:20:32 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60967/tests/kraken/driver.html?testName=audio-oscillator) 07:20:32 INFO - PROCESS | 15334 | RSS: Main: 157413376 07:20:32 INFO - PROCESS | 15334 | 07:20:35 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:35 INFO - PROCESS | 15334 | RSS: Main: 157159424 07:20:35 INFO - PROCESS | 15334 | 07:20:38 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60967/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:39 INFO - PROCESS | 15334 | RSS: Main: 157536256 07:20:39 INFO - PROCESS | 15334 | 07:20:42 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60967/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:43 INFO - PROCESS | 15334 | RSS: Main: 157372416 07:20:43 INFO - PROCESS | 15334 | 07:20:46 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60967/tests/kraken/driver.html?testName=json-parse-financial) 07:20:46 INFO - PROCESS | 15334 | RSS: Main: 157741056 07:20:46 INFO - PROCESS | 15334 | 07:20:48 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:48 INFO - PROCESS | 15334 | RSS: Main: 157540352 07:20:48 INFO - PROCESS | 15334 | 07:20:50 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:51 INFO - PROCESS | 15334 | RSS: Main: 157622272 07:20:51 INFO - PROCESS | 15334 | 07:20:53 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:53 INFO - PROCESS | 15334 | RSS: Main: 158314496 07:20:53 INFO - PROCESS | 15334 | 07:20:56 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:56 INFO - PROCESS | 15334 | RSS: Main: 158519296 07:20:56 INFO - PROCESS | 15334 | 07:20:59 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:21:00 INFO - PROCESS | 15334 | RSS: Main: 158531584 07:21:00 INFO - PROCESS | 15334 | 07:21:01 INFO - PROCESS | 15334 | Cycle 1(1): loaded http://localhost:60967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60967/tests/kraken/driver.html?testName=ai-astar) 07:21:02 INFO - PROCESS | 15334 | RSS: Main: 159981568 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | __start_tp_report 07:21:02 INFO - PROCESS | 15334 | _x_x_mozilla_page_load 07:21:02 INFO - PROCESS | 15334 | _x_x_mozilla_page_load_details 07:21:02 INFO - PROCESS | 15334 | |i|pagename|runs| 07:21:02 INFO - PROCESS | 15334 | |0;ai-astar;109;111;103;110;112;111;101;111;113;110 07:21:02 INFO - PROCESS | 15334 | |1;audio-beat-detection;155;127;167;180;129;156;149;126;176;128 07:21:02 INFO - PROCESS | 15334 | |2;audio-dft;162;163;163;163;162;162;161;163;163;162 07:21:02 INFO - PROCESS | 15334 | |3;audio-fft;74;77;76;173;76;75;74;76;167;75 07:21:02 INFO - PROCESS | 15334 | |4;audio-oscillator;91;91;148;91;91;91;146;93;92;141 07:21:02 INFO - PROCESS | 15334 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;117;117 07:21:02 INFO - PROCESS | 15334 | |6;imaging-darkroom;146;149;147;146;147;147;146;147;148;147 07:21:02 INFO - PROCESS | 15334 | |7;imaging-desaturate;96;95;95;96;96;95;95;95;96;95 07:21:02 INFO - PROCESS | 15334 | |8;json-parse-financial;56;58;58;56;58;57;65;74;58;55 07:21:02 INFO - PROCESS | 15334 | |9;json-stringify-tinderbox;62;58;59;59;59;58;58;59;58;58 07:21:02 INFO - PROCESS | 15334 | |10;stanford-crypto-aes;76;72;81;73;81;82;74;76;79;81 07:21:02 INFO - PROCESS | 15334 | |11;stanford-crypto-ccm;115;113;118;113;123;112;112;116;130;129 07:21:02 INFO - PROCESS | 15334 | |12;stanford-crypto-pbkdf2;160;157;163;165;160;163;161;160;171;165 07:21:02 INFO - PROCESS | 15334 | |13;stanford-crypto-sha256-iterative;67;69;67;68;69;69;66;65;66;68 07:21:02 INFO - PROCESS | 15334 | __end_tp_report 07:21:02 INFO - PROCESS | 15334 | __start_cc_report 07:21:02 INFO - PROCESS | 15334 | _x_x_mozilla_cycle_collect,859 07:21:02 INFO - PROCESS | 15334 | __end_cc_report 07:21:02 INFO - PROCESS | 15334 | __startTimestamp1465222862230__endTimestamp 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | ------- Summary: start ------- 07:21:02 INFO - PROCESS | 15334 | Number of tests: 14 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.93 (3.5%) stddev-sans-first:4.17 07:21:02 INFO - PROCESS | 15334 | Values: 109.0 111.0 103.0 110.0 112.0 111.0 101.0 111.0 113.0 110.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:155.50 stddev:20.96 (13.5%) stddev-sans-first:22.12 07:21:02 INFO - PROCESS | 15334 | Values: 155.0 127.0 167.0 180.0 129.0 156.0 149.0 126.0 176.0 128.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 07:21:02 INFO - PROCESS | 15334 | Values: 162.0 163.0 163.0 163.0 162.0 162.0 161.0 163.0 163.0 162.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:39.93 (52.9%) stddev-sans-first:41.67 07:21:02 INFO - PROCESS | 15334 | Values: 74.0 77.0 76.0 173.0 76.0 75.0 74.0 76.0 167.0 75.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:91.00 stddev:25.94 (28.5%) stddev-sans-first:26.82 07:21:02 INFO - PROCESS | 15334 | Values: 91.0 91.0 148.0 91.0 91.0 91.0 146.0 93.0 92.0 141.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:21:02 INFO - PROCESS | 15334 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 07:21:02 INFO - PROCESS | 15334 | Values: 146.0 149.0 147.0 146.0 147.0 147.0 146.0 147.0 148.0 147.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:21:02 INFO - PROCESS | 15334 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:58.00 stddev:5.78 (10.0%) stddev-sans-first:5.99 07:21:02 INFO - PROCESS | 15334 | Values: 56.0 58.0 58.0 56.0 58.0 57.0 65.0 74.0 58.0 55.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:1.23 (2.1%) stddev-sans-first:0.53 07:21:02 INFO - PROCESS | 15334 | Values: 62.0 58.0 59.0 59.0 59.0 58.0 58.0 59.0 58.0 58.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:80.00 stddev:3.75 (4.7%) stddev-sans-first:3.94 07:21:02 INFO - PROCESS | 15334 | Values: 76.0 72.0 81.0 73.0 81.0 82.0 74.0 76.0 79.0 81.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:117.00 stddev:6.87 (5.9%) stddev-sans-first:7.20 07:21:02 INFO - PROCESS | 15334 | Values: 115.0 113.0 118.0 113.0 123.0 112.0 112.0 116.0 130.0 129.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:3.89 (2.4%) stddev-sans-first:4.02 07:21:02 INFO - PROCESS | 15334 | Values: 160.0 157.0 163.0 165.0 160.0 163.0 161.0 160.0 171.0 165.0 07:21:02 INFO - PROCESS | 15334 | 07:21:02 INFO - PROCESS | 15334 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 07:21:02 INFO - PROCESS | 15334 | Values: 67.0 69.0 67.0 68.0 69.0 69.0 66.0 65.0 66.0 68.0 07:21:02 INFO - PROCESS | 15334 | -------- Summary: end -------- 07:21:02 INFO - PROCESS | 15334 | 07:21:03 INFO - TEST-INFO | 15334: exit 0 07:21:03 INFO - TEST-OK | kraken | took 60925ms 07:21:03 INFO - SUITE-END | took 1170s 07:21:03 INFO - Completed test suite (00:19:31) 07:21:03 INFO - javascript benchmark 07:21:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3401.2857299967004, 3450.551428314319, 3468.167639766456, 3481.982590087049, 3493.248951475434, 5746.798862039829, 5802.12968054792, 5815.069588865772, 5823.796167134151, 5824.563157763168, 5785.884282314361, 5819.534437245021, 5841.269841269841, 5852.414758524156, 5854.531637469003, 5232.529072383485, 5235.162374020158, 5278.181881808326, 5304.257403963448, 5309.230161626562, 5184.688918664892, 5329.25390445338, 5375.3280839895015, 5406.783728650849, 5436.728163591824, 5255.0803609368395, 5316.4683531646715, 5339.706316152629, 5341.519263266306, 5352.277442545265, 5290.7354632268425, 5345.705986170759, 5347.0, 5348.331458567679, 5348.358197016344, 5216.035033518811, 5264.105102132608, 5287.41838397776, 5298.125809241471, 5306.151015837448, 5532.612717109804, 5600.187972743929, 5699.202111704365, 5704.686242256675, 5729.598928075036, 6193.566450348478, 6229.065640153968, 6235.376462353728, 6242.282137554194, 6258.749650013994, 6294.118823364733, 6300.117983482316, 6300.5589608727405, 6303.117563541108, 6305.8108256752375, 5676.460736230051, 5787.1608616750755, 5808.361080281165, 5872.559558033165, 5875.706214689291, 6285.465735412449, 6326.905096423558, 6336.746530138835, 6342.080398342215, 6359.872802543923, 6045.0327947528185, 6053.061775424816, 6076.726547305382, 6105.419985101408, 6111.205543279434, 6206.689665516797, 6279.591826531261, 6279.843003924939, 6298.559100862895, 6317.46301564363, 6100.0, 6116.48009919153, 6130.141780150782, 6130.908036379458, 6135.570510064342, 6075.513958883279, 6115.388461153849, 6133.264008318941, 6136.2636483622255, 6139.171211886338, 4661.790219440133, 4665.906681866344, 4682.882927926829, 4711.0, 4718.245080787057, 4200.642945349679, 4203.138356636943, 4222.0289333453475, 4229.851955181553, 4253.510846252659, 5829.5044921181325, 6033.879322413527, 6038.154658347835, 6042.818715438544, 6043.2748070231855, 6049.546284028627, 6140.95603747364, 6143.38566143391, 6245.531585131133, 6261.5616906816085, 5875.265591801025, 5888.941110588925, 5896.7936122235515, 5918.970405148033, 5966.880662386728, 5153.098207813618, 5295.285136506523, 5296.152615581565, 5307.150855863043, 5310.893782124336, 6353.714082866282, 6360.6501642409185, 6399.616023038632, 6511.804645860631, 6554.180727409074, 6206.441420272197, 6228.750849965951, 6285.874282514233, 6291.213598300213, 6291.622502649856, 6467.062275970052, 6480.902786458113, 6484.221893372825, 6486.318936511787, 6502.349765023459, 6004.519638428827, 6102.694865256631, 6197.81406557804, 6218.595791273553, 6239.438450539473, 6114.480269176992, 6171.13604095418, 6179.351168127461, 6180.258368995749, 6185.938140618716, 5912.408759124053, 5954.880902382015, 5957.821265362046, 6005.249343832021, 6022.54830887694, 5909.52723782105, 5960.046392577166, 6005.279366476051, 6008.489278411384, 6012.488938440107, 5911.408859114054, 5987.670678112571, 6014.6391216527145, 6019.398060193946, 6022.337542870368, 5978.312494063239, 6040.516758659209, 6112.755489780359, 6127.632342059491, 6160.476359509492, 6036.849078773066, 6043.09353596964, 6044.879102418015, 6047.455728984412, 6084.361142080018], "value": 5726.7292333246305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.1653134393945, 659.2517492645846, 669.4711178169243, 676.7969609117265, 697.8325201951527, 37330.81334593327, 37825.43261851074, 38194.0, 38286.42570361447, 38319.616803832025, 39113.60886391135, 39256.41115383265, 39778.204435911335, 39871.0, 39881.40177897334, 8622.353323500747, 8769.561521923879, 8841.513716745576, 8861.778455538599, 8872.37893347466, 8730.301575873915, 8981.416207946495, 9036.50299233542, 9118.589663465127, 9125.863112053325, 8989.41568798026, 9027.819443611124, 9059.682911098113, 9082.54587270637, 9099.0, 8992.055834137453, 8993.955030224839, 9052.411593246417, 9065.954670226673, 9073.364864459458, 8772.912270877338, 8874.112588741074, 8923.0, 8935.061818509028, 8966.686165984225, 38795.41806872899, 39415.40876886849, 39662.801685991384, 39693.0, 39745.0, 3872.206197729487, 3890.474785903895, 3915.099527108752, 4035.2131334389805, 4115.629593336614, 32069.0, 32147.51778723321, 32188.356232875445, 32400.513992290136, 32512.512312315335, 4557.95442045582, 4614.330922016323, 4689.554492323224, 4695.272232803921, 4722.409698787652, 333143.0, 333479.0, 333801.0, 334165.0, 334230.0, 60414.69792651009, 60576.69711651414, 60726.39273607296, 60858.0, 60977.69511152416, 67862.30344241434, 68009.31990680129, 68207.3179268211, 68342.0, 68477.65761171162, 17883.0, 18000.549986250448, 18394.356197533023, 18528.629427411644, 18683.439496815117, 14542.636434089232, 14588.489402870848, 14595.197264150362, 14615.196164211071, 14617.78073328901, 19347.00364330593, 19436.61126777485, 20255.29106481266, 20431.0, 20468.38594842157, 7292.8176795579475, 7421.517601355895, 7472.17806041335, 7625.771226863203, 7684.193159718149, 1093.3494570730402, 1155.2548606148987, 1158.25871442277, 1176.4117941029485, 1193.8360098903672, 32038.35923281521, 32388.190295242806, 32778.344433111204, 32893.0, 33261.50107748386, 1215.9027277817754, 1219.9878001220052, 1259.212991880075, 1302.66476861218, 1310.4758096761373, 17290.827091728923, 17526.64946701059, 17536.47390578285, 17549.385771497935, 17646.558836029202, 485397.0, 525572.0, 839145.0, 856322.0, 860699.0, 60762.088568671505, 61549.0, 61797.0, 61972.38027619666, 62288.37711622826, 1540.7688846673088, 1562.0237351655217, 1562.6093476630842, 1571.3871590079877, 1579.494561740232, 33140.337193256484, 33295.50056749199, 33493.0, 33538.83230583832, 34077.82961085179, 52721.0, 53543.46456535385, 53585.19622205748, 53644.73177634087, 53736.73131634317, 452295.0, 453350.0, 453543.0, 455772.0, 456844.0, 30282.54576181315, 30410.39179216359, 30626.84686576553, 30798.0, 30859.228519287197, 47896.28155577739, 48031.279530806365, 48352.0, 49044.2643360357, 49563.25655115104, 42450.36324455074, 42591.0, 42600.360994585724, 43189.13621727611, 46507.0, 39246.41130383104, 39473.80263098666, 39535.80232098936, 39942.2011559773, 40887.77336679905, 40174.0, 41104.794476027426, 41266.58733412628, 41565.79217103895, 42239.15521689488, 35484.88586367576, 35512.644873551966, 35823.64176358203, 36126.63873361233, 36346.63653363432, 28444.85777571099, 28807.5678864813, 28831.423371532033, 28839.42321153523, 29303.0], "value": 20983.27811321824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.3701573608115, 419.8383622305411, 424.72180721627325, 431.85316992222636, 432.19395826783057, 18534.536636584093, 19228.327008554705, 19249.711254331196, 19318.0, 19886.60226795467, 19503.902480487614, 19836.9008154959, 20209.191632334725, 20708.8964555177, 20738.859362735082, 5664.0937450007905, 5752.194692743019, 5899.734511946951, 5910.379410161936, 5942.049272116462, 5812.099124635667, 5855.092460668603, 5866.6480011199255, 5886.941130588682, 5888.735006924678, 5650.124230744241, 5738.254026976487, 5738.3974682658345, 5890.116482527612, 5905.645661260338, 5774.047282198453, 5819.476247137757, 5826.21346118275, 5834.095715164156, 5844.211031510734, 5082.771275292621, 5249.002689488985, 5254.816081437131, 5346.251524786533, 5364.436734142898, 23476.413089672897, 23669.0, 23874.164404245766, 23882.880585596962, 23935.640965385533, 2447.9388015299583, 2737.0693964052316, 2892.4359749848786, 2993.655729591103, 3310.2882880180637, 14597.708045839025, 14941.252937353089, 15071.397144114222, 15171.089734615958, 15361.539153825403, 1914.5979344337707, 1937.3703546347353, 1996.2414282572674, 2040.1533363654066, 2057.6501994660794, 77651.0, 78461.0, 78679.0, 79448.0, 80033.59983200105, 10966.342019478856, 10971.83542246867, 11333.0, 11341.659750207507, 11566.826497602542, 15365.154916479702, 15494.225288735519, 15579.298931548108, 15677.0, 15690.215489225722, 8972.102789720975, 9065.274778017743, 9065.77335566616, 9226.0, 9233.907660923305, 9075.682351117679, 9172.633094676272, 9226.26189904806, 9311.068893110634, 9381.0618938107, 6851.931480685229, 6903.861922761516, 6953.200381956039, 7004.824879377954, 7065.964670176616, 1964.3026725512236, 1985.2852972929734, 2002.8883969396834, 2020.6867935470025, 2028.705837653532, 1056.7675111475462, 1116.1071143085499, 1152.1992215410378, 1174.7121955120879, 1204.5362535423924, 16794.58013549671, 19953.102110405067, 20196.79803201949, 20282.594348112954, 20418.0, 1135.7047167736448, 1141.041525118904, 1151.234429104636, 1164.295601161302, 1183.71590818203, 11385.544578216779, 11708.414579271002, 11738.413079345999, 11747.941260293645, 11836.526538938346, 454081.0, 461891.0, 463724.0, 466503.0, 468093.0, 49344.50655493399, 76637.0, 76818.23181768223, 77611.61194193993, 79786.0, 1120.0479592346603, 1136.5567428702811, 1138.5502726423017, 1138.59579849154, 1156.6934762288001, 17249.39627113095, 17698.469045928643, 17743.378981736092, 17945.0, 17994.0, 37429.43855842219, 37649.24701506009, 37795.81102094582, 38017.2396552073, 38623.806880965414, 51650.0, 52556.0, 53118.0, 53629.19556206738, 53713.46286537241, 9022.729318120468, 9167.404118732262, 9240.802692210273, 9310.394824336396, 9346.112119348923, 14073.155610663393, 14105.0, 14153.787693184404, 14195.64510887236, 14537.127772333693, 11858.34779087124, 12052.216605920587, 12135.817962730744, 12336.691582710504, 12836.55072072473, 11626.430431891924, 12042.277463352228, 12209.69475763113, 12518.812217816558, 12522.311272880079, 11825.52697892109, 12258.264504129424, 12397.690057748629, 12696.0, 12948.15836970594, 8516.531590762319, 8568.828623427622, 8799.868001980103, 9044.81910361776, 9276.443413395218, 9995.650152244636, 10638.255322127687, 10670.46647667629, 10763.677089687322, 10830.133589312678], "value": 9675.907528302721, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.6904619076186, 1567.843215678432, 1725.0684630299638, 1811.5923917118657, 1816.445983974888, 7875.8424831503335, 8564.0, 8661.913380866197, 8859.379843410956, 8869.46783193008, 8624.741257762262, 8675.349348798834, 8755.080716524753, 8759.649614015432, 8766.868496972551, 2432.075811191749, 2437.402836305099, 2445.572024895645, 2455.2388759484616, 2459.225344016629, 2405.1461731085474, 2428.732839387666, 2429.0648100481353, 2434.318390850565, 2439.609662454008, 2416.2751174647624, 2425.8301918865686, 2435.2450740270483, 2443.218170185541, 2459.397447625325, 2433.7201221859536, 2434.7808697217247, 2459.631055341713, 2466.642336861154, 2470.1601455505124, 2411.7588241175918, 2430.5989511730545, 2431.8662473563945, 2435.768601982809, 2439.6828412306463, 8980.910190898072, 9010.45937243761, 9036.412633178888, 9057.818843623156, 9058.682946096855, 5352.223927530486, 5471.7264136793, 5483.917741233885, 5486.670799751988, 5506.504414602665, 3465.6361082086523, 3529.6470352964757, 3577.3739595570933, 3605.441156620702, 3619.6561326673923, 1152.9654110376619, 1161.6863446869297, 1178.7053236690826, 1206.2400687566865, 1210.8910198082215, 12465.252084874937, 12475.875241247653, 12622.305773182472, 12622.431990560446, 12667.683307917283, 4692.967547139624, 4695.436547614308, 4783.234682450791, 4811.78346974387, 4817.253325734517, 10580.682579522627, 10588.947055264674, 10695.197860160519, 10729.570817167227, 10735.248532602798, 5394.460553944653, 5449.346078470529, 5471.863203419946, 5473.67157970523, 5475.808346707846, 4449.2658711312915, 4941.802327906916, 4985.725785081855, 5034.546890779848, 5071.2139618359215, 4215.220184265921, 4238.766867822238, 4271.060366719316, 4323.935140972888, 4326.848560300375, 1381.109184575943, 1392.9024968252327, 1396.7974643676814, 1419.198153043527, 1420.708754705283, 1090.5910283643634, 1093.3822390349585, 1098.7143342730787, 1102.459794700591, 1104.9668509944715, 6190.473809726133, 6314.210723659543, 6379.649119298483, 6392.584482008655, 6531.183602049744, 482.93721816163674, 486.3021564055592, 490.7865078690781, 492.6305271046715, 499.24115344676613, 4389.100234451929, 4398.494173170063, 4437.622802061796, 4452.710573812692, 4469.262571675637, 10915.072218861485, 11126.944365278121, 11196.720081998015, 11256.324620522795, 11259.887401125883, 10818.621348252931, 11010.834837477445, 11098.889011109946, 11221.495032723547, 11230.438478076063, 8545.957270213734, 8639.13608639131, 8670.739877803677, 8686.391952563386, 8721.215090641872, 6037.78867739627, 6121.173641558511, 6125.387461253839, 6223.066540019034, 6250.031245157008, 9626.326157169211, 9853.06395892389, 9873.160781333667, 9875.851862222216, 10160.034796694303, 10046.69859904204, 10100.141487973604, 10148.543315550965, 10230.641927532799, 10240.539175737258, 7674.846503069795, 7840.176781438095, 7897.763067107996, 8081.030276366873, 8162.469439486415, 8303.04514980785, 8324.0427350853, 8347.457415267989, 8427.915720842713, 8458.196471335214, 7466.141393739789, 7685.03937007874, 7733.690652374067, 7778.0666320041955, 7799.727009554638, 7191.42468602521, 7322.414206863545, 7371.668274927534, 7394.926050739424, 7428.0, 7226.638668066681, 7230.710771569078, 7267.890981635174, 7318.926810731825, 7323.340899319087, 5326.707031113326, 5332.440093790251, 5390.784368625211, 5443.992861320668, 5496.615236933376, 5295.073362161529, 5295.814646487354, 5296.417394086724, 5309.178647630007, 5341.75962081715], "value": 4718.879296144665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.445505012181, 369.07178446207786, 372.4264632466002, 378.7178551978776, 379.7987066854568, 6491.383318584739, 6644.402003819661, 6675.699593518291, 6751.797446076619, 6772.2889096644885, 6646.302138275484, 6654.667266636661, 6657.0, 6682.398584127428, 6695.866082678343, 5025.321581586476, 5060.671056381342, 5062.974685126569, 5072.26452164436, 5081.034603425356, 5071.1632580624155, 5077.121465057934, 5081.7459127043685, 5081.898362032775, 5083.949160508385, 5022.598192144638, 5024.171011783052, 5027.2207807789855, 5030.798768049273, 5047.0915235257635, 4938.728369939652, 5001.124803159432, 5014.648974571782, 5022.673526220784, 5051.343325367716, 4374.278244089754, 4391.9020244938765, 4393.055493069006, 4409.889752756175, 4412.669049821244, 6404.167458230447, 6426.325235850262, 6432.5497215194955, 6436.0, 6448.613083215022, 5868.09044598088, 5917.467427931464, 5924.4667979882015, 5929.881402371929, 5934.970325148347, 7047.859042819115, 7048.259932707095, 7050.858982820315, 7057.329553692391, 7071.222165561784, 4613.238815595423, 4756.762161891892, 4762.309465127537, 4922.532359425849, 4929.7781599828095, 7201.243869393743, 7296.087989001375, 7317.926820731831, 7338.669759860819, 7355.779326620156, 4868.318435419044, 4869.9513004870205, 4870.6103511718975, 4874.390701162355, 4874.4150701916, 4917.827876024322, 4919.409670839451, 4930.9506904930495, 4934.950650493521, 4954.727489988085, 5760.711964401763, 5764.0, 5773.855653608609, 5781.277340332458, 5788.855278617984, 6939.93060069403, 7035.859282814315, 7048.823779405556, 7062.71749130029, 7062.894056589155, 1715.2881554155135, 1736.9913150434168, 1738.2959901239765, 1745.424010076697, 1751.3082332478855, 1118.072000239799, 1119.7144728094283, 1134.387430787382, 1148.6496618531262, 1150.1891166727437, 6826.180858296937, 6841.418479429304, 6864.450843932474, 6870.862582748317, 6890.552114112566, 7213.8557228855125, 7216.639168041577, 7221.711131554784, 7271.127464704269, 7301.2333704961275, 6789.0, 6853.965730171317, 6858.245592984767, 6860.416864566568, 6871.931280687129, 3849.2301539692176, 3875.5736868944396, 3891.669208117285, 3922.7450215736458, 3927.489426374553, 7459.3286604204795, 7530.736424225126, 7569.091708994956, 7588.582627955516, 7602.50583712057, 7323.414126869838, 7328.120625524864, 7346.853062938711, 7348.448866335047, 7379.6679149438405, 7521.586312752742, 7531.623418829036, 7542.434317426215, 7547.320741133434, 7563.470557061063, 6951.131108611424, 7139.964300178466, 7172.354488095888, 7175.425965922609, 7229.0, 7088.468364872552, 7094.574325540484, 7103.9289607103265, 7105.75129870452, 7110.0, 7526.736564220226, 7535.171131175457, 7545.283198096172, 7549.471536992577, 7567.962160189164, 4865.416150062015, 4866.489018653132, 4867.367242258484, 4876.536729010738, 4898.8775280618265, 7056.223815380202, 7163.6060016699585, 7170.928290717026, 7203.207647158703, 7206.6396680164735, 6943.993120997326, 6978.267281935324, 7041.3310735480045, 7082.929170708433, 7106.0, 7032.964835175996, 7084.752033678797, 7090.255523169993, 7104.0, 7120.893186602101, 6923.861522769415, 6945.992831039572, 6950.8609827804175, 6957.1651401832105, 6971.965140174267, 6996.545224560387, 7091.290870912868, 7163.964180179066, 7169.247229040876, 7189.209186989322, 6852.349026842442, 6964.9900764389895, 6982.685779140053, 6984.092068031124, 7006.334398232159], "value": 5285.987174749384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.9273658107352, 918.1552971266439, 920.3925409229907, 921.9769505762355, 942.4722155592864, 14353.354099065527, 14427.927860360696, 14574.56276311711, 14926.104433733983, 14973.0, 13859.307034648253, 13881.09772864763, 13884.444622215124, 13897.166170029805, 13919.582412527616, 874.921257086862, 885.9943963601327, 892.0455113029029, 892.1524551675934, 892.6607889002203, 880.1726377205406, 898.3307435960186, 918.6555041859302, 922.5018490015384, 922.7646950027768, 936.5130132331184, 944.2351695126969, 946.9715908522755, 949.8432758594823, 950.8145911547251, 936.3118108190474, 941.1952780372785, 943.3443756589173, 943.4716558727134, 945.8675785390051, 691.0360047733434, 692.7679227458807, 693.386353077525, 694.0144994108379, 694.2190036209265, 15056.774148387783, 15089.622759430993, 15096.094234345974, 15100.697986040328, 15102.471413500474, 13614.591562253148, 13655.863441365558, 13788.0, 14029.088109272865, 14312.42750289987, 11999.400029998465, 12016.0, 12047.57833475833, 12092.093093018058, 12177.756444871053, 3964.1278918637854, 4002.3596224603925, 4027.416024676435, 4047.919041619151, 4094.7338423002707, 57478.137827932616, 57907.71046144742, 58207.70896145535, 58257.70871145617, 58275.708621457045, 10147.543360548792, 10367.222458315657, 10445.216608754374, 10563.894361056291, 10586.20603454744, 18962.051897405076, 19045.80954190468, 19074.14166362517, 19082.52293692641, 19101.331453399063, 8233.423660343838, 8318.8336233275, 8332.04181519133, 8549.871751923725, 8813.383063185644, 4795.592374648124, 4883.804647814119, 4899.6570240083565, 4933.679310844784, 4982.177940639826, 3635.9091022724115, 3675.46705727668, 3679.5400574928135, 3697.7781333120097, 3704.036950392863, 564.5963136357442, 627.5230824573357, 632.3076231526471, 635.7997230872261, 636.2746469025315, 689.8689249042666, 770.6228621430218, 781.0588241169377, 790.9367250619937, 794.8450052239873, 10183.083522483012, 10351.378917264989, 10450.477476126163, 10465.738356541147, 10605.257631965842, 733.2777214443769, 789.289639324601, 797.3063434811635, 814.3851392198852, 821.9766390843319, 4537.09258148365, 4579.95420045802, 4726.338312636233, 4780.976095119572, 4800.255960326155, 65119.67440162864, 66453.66773166103, 66513.0, 66550.0, 66772.3322766766, 54444.183337249975, 55921.72039139778, 56477.43522564804, 56888.71555642195, 57597.42402576005, 50902.23646645303, 51734.482655172964, 52368.0, 52939.73530132325, 52953.7352313236, 9434.95282523583, 9446.480443575669, 9494.620215191591, 9600.807983840145, 9623.470709111067, 38796.0, 39362.0, 39649.20701585894, 39654.603453965094, 39865.0, 46938.530614693416, 49875.50124498854, 50159.0, 50348.196029615465, 50801.49198507968, 11195.496202671062, 11327.433628318717, 11433.142514311627, 11484.081273497934, 11525.654230372767, 12665.683357916127, 12667.17663351916, 13091.934540327238, 13208.603741887759, 13332.533361332307, 11592.6522204334, 11756.470958807045, 11833.230839995716, 11845.644630661094, 12053.939730301643, 11802.76394472123, 11872.0, 12021.45903434365, 12216.938915305722, 12368.134230603771, 11313.490892910004, 11507.654770356903, 11509.194356394972, 11640.476178572155, 11980.341081240615, 10184.694459166238, 10379.273450858367, 10406.947965260428, 10428.0, 10648.520816563429, 10125.0, 10627.309224900666, 10669.839952400875, 10696.679099627023, 10730.89269107299], "value": 7024.246211632447, "unit": "score"}], "name": "dromaeo_css", "value": 7670.888819222039, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 103.0, 110.0, 112.0, 111.0, 101.0, 111.0, 113.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 167.0, 180.0, 129.0, 156.0, 149.0, 126.0, 176.0, 128.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 161.0, 163.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 173.0, 76.0, 75.0, 74.0, 76.0, 167.0, 75.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 148.0, 91.0, 91.0, 91.0, 146.0, 93.0, 92.0, 141.0], "value": 107.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 56.0, 58.0, 57.0, 65.0, 74.0, 58.0, 55.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 81.0, 73.0, 81.0, 82.0, 74.0, 76.0, 79.0, 81.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 118.0, 113.0, 123.0, 112.0, 112.0, 116.0, 130.0, 129.0], "value": 118.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 163.0, 165.0, 160.0, 163.0, 161.0, 160.0, 171.0, 165.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 68.0, 69.0, 69.0, 66.0, 65.0, 66.0, 68.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1526.0999999999997, "alertThreshold": 2.0}]} 07:21:03 INFO - Return code: 0 07:21:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:21:03 ERROR - # TBPL SUCCESS # 07:21:03 INFO - Running post-action listener: _resource_record_post_action 07:21:03 INFO - Running post-run listener: _resource_record_post_run 07:21:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 498982912; Read time: 0; Write time: 405164 07:21:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 242585600; Read time: 0; Write time: 242448 07:21:04 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249585664; Read time: 0; Write time: 161144 07:21:04 INFO - Running post-run listener: _upload_blobber_files 07:21:04 INFO - Blob upload gear active. 07:21:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:21:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:21:05 INFO - (blobuploader) - INFO - Open directory for files ... 07:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:05 INFO - (blobuploader) - INFO - Done attempting. 07:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:06 INFO - (blobuploader) - INFO - Done attempting. 07:21:06 INFO - (blobuploader) - INFO - Iteration through files over. 07:21:06 INFO - Return code: 0 07:21:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:21:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:21:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ac38fccfbf2f1d4cc00b3794891557590a8fc056d6e99c9fbd4d65e5f7114e444bd0139817bcb2e2270c6aa1987f09ddc2af072a92e7deea8ef98873583eef5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3683096ae8024c25d5bd630a8daea15bfcdb4ed47362c3504acbbf1f20db1a041da0ff57a1b03b0ee4aed375d22a5f201f92a98c6aff249e258608036db5d428"} 07:21:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:21:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:21:06 INFO - Contents: 07:21:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ac38fccfbf2f1d4cc00b3794891557590a8fc056d6e99c9fbd4d65e5f7114e444bd0139817bcb2e2270c6aa1987f09ddc2af072a92e7deea8ef98873583eef5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3683096ae8024c25d5bd630a8daea15bfcdb4ed47362c3504acbbf1f20db1a041da0ff57a1b03b0ee4aed375d22a5f201f92a98c6aff249e258608036db5d428"} 07:21:06 INFO - Running post-run listener: copy_logs_to_upload_dir 07:21:06 INFO - Copying logs to upload dir... 07:21:06 INFO - mkdir: /builds/slave/test/build/upload/logs 07:21:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.610241 ========= master_lag: 3.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-06 07:21:09.682636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:09.685988) ========= 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=eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969 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/6ac38fccfbf2f1d4cc00b3794891557590a8fc056d6e99c9fbd4d65e5f7114e444bd0139817bcb2e2270c6aa1987f09ddc2af072a92e7deea8ef98873583eef5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3683096ae8024c25d5bd630a8daea15bfcdb4ed47362c3504acbbf1f20db1a041da0ff57a1b03b0ee4aed375d22a5f201f92a98c6aff249e258608036db5d428"} build_url:https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010427 build_url: 'https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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/6ac38fccfbf2f1d4cc00b3794891557590a8fc056d6e99c9fbd4d65e5f7114e444bd0139817bcb2e2270c6aa1987f09ddc2af072a92e7deea8ef98873583eef5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3683096ae8024c25d5bd630a8daea15bfcdb4ed47362c3504acbbf1f20db1a041da0ff57a1b03b0ee4aed375d22a5f201f92a98c6aff249e258608036db5d428"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:09.711636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:09.711952) ========= 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=eca2ab57546de7b41f256b19000001ef-1465221637.772089-957058969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:09.956828) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 07:21:09.957167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 07:21:09.957476) ========= ========= Total master_lag: 3.90 =========