builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1464648677.86 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:17.856712) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:17.857280) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:17.857669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:17.879280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:17.879641) ========= 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-1464647932.455281-1419684258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 15:51:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-30 15:51:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139947 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.034594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.034897) ========= 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-1464647932.455281-1419684258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017958 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.084311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.084678) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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-1464647932.455281-1419684258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 15:51:18,451 truncating revision to first 12 chars 2016-05-30 15:51:18,451 Setting DEBUG logging. 2016-05-30 15:51:18,451 attempt 1/10 2016-05-30 15:51:18,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 15:51:18,791 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.768014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.768333) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.768765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.769037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:51:18.779448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-30 15:51:18.779828) ========= /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-1464647932.455281-1419684258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:19 INFO - MultiFileLogger online at 20160530 15:51:19 in /builds/slave/test 15:51:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:51:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:19 INFO - {'append_to_log': False, 15:51:19 INFO - 'base_work_dir': '/builds/slave/test', 15:51:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:51:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:19 INFO - 'branch': 'Mozilla-Aurora', 15:51:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:19 INFO - 'config_files': ('talos/linux_config.py',), 15:51:19 INFO - 'default_actions': ('clobber', 15:51:19 INFO - 'read-buildbot-config', 15:51:19 INFO - 'download-and-extract', 15:51:19 INFO - 'populate-webroot', 15:51:19 INFO - 'create-virtualenv', 15:51:19 INFO - 'install', 15:51:19 INFO - 'run-tests'), 15:51:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:19 INFO - 'download_minidump_stackwalk': True, 15:51:19 INFO - 'download_symbols': 'ondemand', 15:51:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:19 INFO - 'installer_path': 'installer.exe', 15:51:19 INFO - 'log_level': 'info', 15:51:19 INFO - 'log_name': 'talos', 15:51:19 INFO - 'log_to_console': True, 15:51:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:19 INFO - 'opt_config_files': (), 15:51:19 INFO - 'pip_index': False, 15:51:19 INFO - 'sps_profile': False, 15:51:19 INFO - 'sps_profile_interval': 0, 15:51:19 INFO - 'suite': 'dromaeojs-e10s', 15:51:19 INFO - 'system_bits': '32', 15:51:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:19 INFO - 'title': 'talos-linux64-ix-010', 15:51:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:19 INFO - 'use_talos_json': True, 15:51:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:19 INFO - 'work_dir': 'build'} 15:51:19 INFO - ##### 15:51:19 INFO - ##### Running clobber step. 15:51:19 INFO - ##### 15:51:19 INFO - Running pre-action listener: _resource_record_pre_action 15:51:19 INFO - Running main action method: clobber 15:51:19 INFO - rmtree: /builds/slave/test/build 15:51:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:19 INFO - Running post-action listener: _resource_record_post_action 15:51:19 INFO - ##### 15:51:19 INFO - ##### Running read-buildbot-config step. 15:51:19 INFO - ##### 15:51:19 INFO - Running pre-action listener: _resource_record_pre_action 15:51:19 INFO - Running main action method: read_buildbot_config 15:51:19 INFO - Using buildbot properties: 15:51:19 INFO - { 15:51:19 INFO - "project": "", 15:51:19 INFO - "product": "firefox", 15:51:19 INFO - "script_repo_revision": "production", 15:51:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:51:19 INFO - "repository": "", 15:51:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:51:19 INFO - "buildid": "20160530120549", 15:51:19 INFO - "pgo_build": "True", 15:51:19 INFO - "basedir": "/builds/slave/test", 15:51:19 INFO - "buildnumber": 314, 15:51:19 INFO - "slavename": "talos-linux64-ix-010", 15:51:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:51:19 INFO - "platform": "ubuntu64_hw", 15:51:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:51:19 INFO - "branch": "mozilla-aurora", 15:51:19 INFO - "repo_path": "releases/mozilla-aurora", 15:51:19 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 15:51:19 INFO - "stage_platform": "linux64-pgo", 15:51:19 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 15:51:19 INFO - "slavebuilddir": "test" 15:51:19 INFO - } 15:51:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 15:51:19 INFO - Running post-action listener: _resource_record_post_action 15:51:19 INFO - ##### 15:51:19 INFO - ##### Running download-and-extract step. 15:51:19 INFO - ##### 15:51:19 INFO - Running pre-action listener: _resource_record_pre_action 15:51:19 INFO - Running main action method: download_and_extract 15:51:19 INFO - mkdir: /builds/slave/test/build/tests 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:20 INFO - Downloaded 1361 bytes. 15:51:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:51:20 INFO - Using the following test package requirements: 15:51:20 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:51:20 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:20 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:51:20 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'jsshell-linux-x86_64.zip'], 15:51:20 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:20 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:51:20 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:51:20 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:51:20 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:20 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:51:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:20 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51:20 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')]} 15:51:20 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:21 INFO - Downloaded 24173994 bytes. 15:51:21 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'] 15:51:21 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 15:51:22 INFO - Return code: 0 15:51:22 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 15:51:22 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')]} 15:51:22 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:29 INFO - Downloaded 24173994 bytes. 15:51:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:51:31 INFO - Return code: 0 15:51: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')]} 15:51:31 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:32 INFO - Downloaded 10840145 bytes. 15:51:32 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'] 15:51:32 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 15:51:32 INFO - Return code: 0 15:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:32 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:34 INFO - Downloaded 62800628 bytes. 15:51:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:34 INFO - mkdir: /builds/slave/test/properties 15:51:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:34 INFO - Contents: 15:51:34 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:35 INFO - Running post-action listener: _resource_record_post_action 15:51:35 INFO - Running post-action listener: set_extra_try_arguments 15:51:35 INFO - ##### 15:51:35 INFO - ##### Running populate-webroot step. 15:51:35 INFO - ##### 15:51:35 INFO - Running pre-action listener: _resource_record_pre_action 15:51:35 INFO - Running main action method: populate_webroot 15:51:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:35 INFO - '--tppagecycles', 15:51:35 INFO - '7'], 15:51:35 INFO - 'tests': ['tsvgm']}}, 15:51:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['damp', 'tps']}, 15:51:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'tests': ['damp', 'tps']}, 15:51:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['dromaeo_dom']}, 15:51:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['a11yr', 15:51:35 INFO - 'ts_paint', 15:51:35 INFO - 'tpaint', 15:51:35 INFO - 'sessionrestore', 15:51:35 INFO - 'sessionrestore_no_auto_restore', 15:51:35 INFO - 'tabpaint']}, 15:51:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:35 INFO - 'ts_paint', 15:51:35 INFO - 'tpaint', 15:51:35 INFO - 'sessionrestore', 15:51:35 INFO - 'sessionrestore_no_auto_restore', 15:51:35 INFO - 'tabpaint']}, 15:51:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:35 INFO - 'ts_paint', 15:51:35 INFO - 'tpaint', 15:51:35 INFO - 'sessionrestore', 15:51:35 INFO - 'sessionrestore_no_auto_restore', 15:51:35 INFO - 'tabpaint']}, 15:51:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:35 INFO - 'ts_paint', 15:51:35 INFO - 'tpaint', 15:51:35 INFO - 'sessionrestore', 15:51:35 INFO - 'sessionrestore_no_auto_restore', 15:51:35 INFO - 'tabpaint']}, 15:51:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['a11yr', 15:51:35 INFO - 'ts_paint', 15:51:35 INFO - 'tpaint', 15:51:35 INFO - 'sessionrestore', 15:51:35 INFO - 'sessionrestore_no_auto_restore', 15:51:35 INFO - 'tabpaint']}, 15:51:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['a11yr', 15:51:35 INFO - 'ts_paint', 15:51:35 INFO - 'tpaint', 15:51:35 INFO - 'sessionrestore', 15:51:35 INFO - 'sessionrestore_no_auto_restore', 15:51:35 INFO - 'tabpaint']}, 15:51:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['tsvgx', 15:51:35 INFO - 'tsvgr_opacity', 15:51:35 INFO - 'tart', 15:51:35 INFO - 'tscrollx', 15:51:35 INFO - 'cart']}, 15:51:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:35 INFO - 'tsvgr_opacity', 15:51:35 INFO - 'tart', 15:51:35 INFO - 'tscrollx', 15:51:35 INFO - 'cart']}, 15:51:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'talos_options': ['--disable-e10s'], 15:51:35 INFO - 'tests': ['tp5o']}, 15:51:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'tests': ['tp5o']}, 15:51:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'talos_options': ['--disable-e10s', 15:51:35 INFO - '--xperf_path', 15:51:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:35 INFO - 'tests': ['tp5n']}, 15:51:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:35 INFO - 'talos_options': ['--xperf_path', 15:51:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:35 INFO - 'tests': ['tp5n']}}, 15:51:35 INFO - 'talos.zip': {'path': '', 15:51:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:35 INFO - Running post-action listener: _resource_record_post_action 15:51:35 INFO - ##### 15:51:35 INFO - ##### Running create-virtualenv step. 15:51:35 INFO - ##### 15:51:35 INFO - Running pre-action listener: _resource_record_pre_action 15:51:35 INFO - Running main action method: create_virtualenv 15:51:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:35 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 15:51:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:35 INFO - Using real prefix '/usr' 15:51:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:37 INFO - Installing pip.................done. 15:51:37 INFO - Return code: 0 15:51:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:37 INFO - Using env: {'DISPLAY': ':0', 15:51:37 INFO - 'HOME': '/home/cltbld', 15:51:37 INFO - 'LANG': 'en_US.UTF-8', 15:51:37 INFO - 'LANGUAGE': 'en_US:en', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MAIL': '/var/mail/cltbld', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SHLVL': '1', 15:51:37 INFO - 'TERM': 'linux', 15:51:37 INFO - 'TMOUT': '86400', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - '_': '/tools/buildbot/bin/python'} 15:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:51:37 INFO - Cleaning up... 15:51:37 INFO - Return code: 0 15:51:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:51:37 INFO - Using env: {'DISPLAY': ':0', 15:51:37 INFO - 'HOME': '/home/cltbld', 15:51:37 INFO - 'LANG': 'en_US.UTF-8', 15:51:37 INFO - 'LANGUAGE': 'en_US:en', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MAIL': '/var/mail/cltbld', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SHLVL': '1', 15:51:37 INFO - 'TERM': 'linux', 15:51:37 INFO - 'TMOUT': '86400', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - '_': '/tools/buildbot/bin/python'} 15:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:38 INFO - Downloading/unpacking psutil>=0.7.1 15:51:38 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 15:51:38 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 15:51:38 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 15:51:38 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 15:51:38 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 15:51:38 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 15:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:40 INFO - Installing collected packages: psutil 15:51:40 INFO - Running setup.py install for psutil 15:51:40 INFO - building 'psutil._psutil_linux' extension 15:51:40 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 15:51:40 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 15:51:40 INFO - building 'psutil._psutil_posix' extension 15:51:40 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 15:51:40 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 15:51:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:40 INFO - Successfully installed psutil 15:51:40 INFO - Cleaning up... 15:51:40 INFO - Return code: 0 15:51:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:40 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 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51:40 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 15:51:40 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 15:51:40 INFO - Using env: {'DISPLAY': ':0', 15:51:40 INFO - 'HOME': '/home/cltbld', 15:51:40 INFO - 'LANG': 'en_US.UTF-8', 15:51:40 INFO - 'LANGUAGE': 'en_US:en', 15:51:40 INFO - 'LOGNAME': 'cltbld', 15:51:40 INFO - 'MAIL': '/var/mail/cltbld', 15:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:40 INFO - 'MOZ_NO_REMOTE': '1', 15:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:40 INFO - 'NO_EM_RESTART': '1', 15:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:40 INFO - 'PWD': '/builds/slave/test', 15:51:40 INFO - 'SHELL': '/bin/bash', 15:51:40 INFO - 'SHLVL': '1', 15:51:40 INFO - 'TERM': 'linux', 15:51:40 INFO - 'TMOUT': '86400', 15:51:40 INFO - 'USER': 'cltbld', 15:51:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:40 INFO - '_': '/tools/buildbot/bin/python'} 15:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:42 INFO - Installing collected packages: mozsystemmonitor 15:51:42 INFO - Running setup.py install for mozsystemmonitor 15:51:42 INFO - Successfully installed mozsystemmonitor 15:51:42 INFO - Cleaning up... 15:51:43 INFO - Return code: 0 15:51:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:43 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 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51:43 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 15:51:43 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 15:51:43 INFO - Using env: {'DISPLAY': ':0', 15:51:43 INFO - 'HOME': '/home/cltbld', 15:51:43 INFO - 'LANG': 'en_US.UTF-8', 15:51:43 INFO - 'LANGUAGE': 'en_US:en', 15:51:43 INFO - 'LOGNAME': 'cltbld', 15:51:43 INFO - 'MAIL': '/var/mail/cltbld', 15:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:43 INFO - 'MOZ_NO_REMOTE': '1', 15:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:43 INFO - 'NO_EM_RESTART': '1', 15:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:43 INFO - 'PWD': '/builds/slave/test', 15:51:43 INFO - 'SHELL': '/bin/bash', 15:51:43 INFO - 'SHLVL': '1', 15:51:43 INFO - 'TERM': 'linux', 15:51:43 INFO - 'TMOUT': '86400', 15:51:43 INFO - 'USER': 'cltbld', 15:51:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:43 INFO - '_': '/tools/buildbot/bin/python'} 15:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:43 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:43 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 15:51:43 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 15:51:43 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 15:51:43 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 15:51:43 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 15:51:43 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 15:51:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 INFO - Downloading docopt-0.6.1.tar.gz 15:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:45 INFO - Running setup.py install for blobuploader 15:51:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:46 INFO - Running setup.py install for requests 15:51:46 INFO - Running setup.py install for docopt 15:51:46 INFO - Successfully installed blobuploader requests docopt 15:51:46 INFO - Cleaning up... 15:51:46 INFO - Return code: 0 15:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:46 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 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51:46 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 15:51:46 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 15:51:46 INFO - Using env: {'DISPLAY': ':0', 15:51:46 INFO - 'HOME': '/home/cltbld', 15:51:46 INFO - 'LANG': 'en_US.UTF-8', 15:51:46 INFO - 'LANGUAGE': 'en_US:en', 15:51:46 INFO - 'LOGNAME': 'cltbld', 15:51:46 INFO - 'MAIL': '/var/mail/cltbld', 15:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:46 INFO - 'MOZ_NO_REMOTE': '1', 15:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:46 INFO - 'NO_EM_RESTART': '1', 15:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:46 INFO - 'PWD': '/builds/slave/test', 15:51:46 INFO - 'SHELL': '/bin/bash', 15:51:46 INFO - 'SHLVL': '1', 15:51:46 INFO - 'TERM': 'linux', 15:51:46 INFO - 'TMOUT': '86400', 15:51:46 INFO - 'USER': 'cltbld', 15:51:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:46 INFO - '_': '/tools/buildbot/bin/python'} 15:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:46 INFO - Running setup.py (path:/tmp/pip-ZQivGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:46 INFO - Running setup.py (path:/tmp/pip-FWH5b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:46 INFO - Running setup.py (path:/tmp/pip-s8gJuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:46 INFO - Running setup.py (path:/tmp/pip-nRZXvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:47 INFO - Running setup.py (path:/tmp/pip-OI2jdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:47 INFO - Running setup.py (path:/tmp/pip-sH7yGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:47 INFO - Running setup.py (path:/tmp/pip-9fd2ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:47 INFO - Running setup.py (path:/tmp/pip-1jkKoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:47 INFO - Running setup.py (path:/tmp/pip-IlhUSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:47 INFO - Running setup.py (path:/tmp/pip-GVx5wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:47 INFO - Running setup.py (path:/tmp/pip-PDDGZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:47 INFO - Running setup.py (path:/tmp/pip-pwZPGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:47 INFO - Running setup.py (path:/tmp/pip-HWdHKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:47 INFO - Running setup.py (path:/tmp/pip-6irA65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:47 INFO - Running setup.py (path:/tmp/pip-iudPu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:47 INFO - Running setup.py (path:/tmp/pip-Kcj9pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:47 INFO - Running setup.py (path:/tmp/pip-VlLy23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:47 INFO - Running setup.py install for manifestparser 15:51:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Running setup.py install for mozcrash 15:51:48 INFO - Running setup.py install for mozdebug 15:51:48 INFO - Running setup.py install for mozdevice 15:51:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Running setup.py install for mozfile 15:51:48 INFO - Running setup.py install for mozhttpd 15:51:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Running setup.py install for mozinfo 15:51:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Running setup.py install for mozInstall 15:51:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Running setup.py install for mozleak 15:51:48 INFO - Running setup.py install for mozlog 15:51:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Running setup.py install for moznetwork 15:51:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:49 INFO - Running setup.py install for mozprocess 15:51:49 INFO - Running setup.py install for mozprofile 15:51:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:49 INFO - Running setup.py install for mozrunner 15:51:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:49 INFO - Running setup.py install for mozscreenshot 15:51:49 INFO - Running setup.py install for moztest 15:51:49 INFO - Running setup.py install for mozversion 15:51:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:49 INFO - Cleaning up... 15:51:49 INFO - Return code: 0 15:51:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:49 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 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51:49 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 15:51:49 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 15:51:49 INFO - Using env: {'DISPLAY': ':0', 15:51:49 INFO - 'HOME': '/home/cltbld', 15:51:49 INFO - 'LANG': 'en_US.UTF-8', 15:51:49 INFO - 'LANGUAGE': 'en_US:en', 15:51:49 INFO - 'LOGNAME': 'cltbld', 15:51:49 INFO - 'MAIL': '/var/mail/cltbld', 15:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:49 INFO - 'MOZ_NO_REMOTE': '1', 15:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:49 INFO - 'NO_EM_RESTART': '1', 15:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:49 INFO - 'PWD': '/builds/slave/test', 15:51:49 INFO - 'SHELL': '/bin/bash', 15:51:49 INFO - 'SHLVL': '1', 15:51:49 INFO - 'TERM': 'linux', 15:51:49 INFO - 'TMOUT': '86400', 15:51:49 INFO - 'USER': 'cltbld', 15:51:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:49 INFO - '_': '/tools/buildbot/bin/python'} 15:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:49 INFO - Running setup.py (path:/tmp/pip-9SKx8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:50 INFO - Running setup.py (path:/tmp/pip-1EGvkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:50 INFO - Running setup.py (path:/tmp/pip-Rlgc5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:50 INFO - Running setup.py (path:/tmp/pip-5m_lup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:50 INFO - Running setup.py (path:/tmp/pip-UFmXjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:50 INFO - Running setup.py (path:/tmp/pip-ghicn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:50 INFO - Running setup.py (path:/tmp/pip-7gf4Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:50 INFO - Running setup.py (path:/tmp/pip-CF8fFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:50 INFO - Running setup.py (path:/tmp/pip-RWP_KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:50 INFO - Running setup.py (path:/tmp/pip-zTBeZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:50 INFO - Running setup.py (path:/tmp/pip-Gj1NMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:50 INFO - Running setup.py (path:/tmp/pip-eOWiCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:50 INFO - Running setup.py (path:/tmp/pip-WcRg0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:50 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)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:50 INFO - Running setup.py (path:/tmp/pip-RwDUtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:50 INFO - Running setup.py (path:/tmp/pip-2Y1dtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:51 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)) 15:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:51 INFO - Running setup.py (path:/tmp/pip-hRQtyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:51 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)) 15:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:51 INFO - Running setup.py (path:/tmp/pip-fBEwk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:51 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)) 15:51:51 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)) 15:51:51 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)) 15:51:51 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)) 15:51:51 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)) 15:51:51 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)) 15:51:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:53 INFO - Downloading blessings-1.6.tar.gz 15:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:53 INFO - Installing collected packages: blessings 15:51:53 INFO - Running setup.py install for blessings 15:51:53 INFO - Successfully installed blessings 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:53 INFO - Reading from file tmpfile_stdout 15:51:53 INFO - Current package versions: 15:51:53 INFO - argparse == 1.2.1 15:51:53 INFO - blessings == 1.6 15:51:53 INFO - blobuploader == 1.2.4 15:51:53 INFO - docopt == 0.6.1 15:51:53 INFO - manifestparser == 1.1 15:51:53 INFO - mozInstall == 1.12 15:51:53 INFO - mozcrash == 0.17 15:51:53 INFO - mozdebug == 0.1 15:51:53 INFO - mozdevice == 0.48 15:51:53 INFO - mozfile == 1.2 15:51:53 INFO - mozhttpd == 0.7 15:51:53 INFO - mozinfo == 0.9 15:51:53 INFO - mozleak == 0.1 15:51:53 INFO - mozlog == 3.1 15:51:53 INFO - moznetwork == 0.27 15:51:53 INFO - mozprocess == 0.22 15:51:53 INFO - mozprofile == 0.28 15:51:53 INFO - mozrunner == 6.11 15:51:53 INFO - mozscreenshot == 0.1 15:51:53 INFO - mozsystemmonitor == 0.0 15:51:53 INFO - moztest == 0.7 15:51:53 INFO - mozversion == 1.4 15:51:53 INFO - psutil == 3.1.1 15:51:53 INFO - requests == 1.2.3 15:51:53 INFO - wsgiref == 0.1.2 15:51:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:53 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 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51:53 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 15:51:53 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 15:51:53 INFO - Using env: {'DISPLAY': ':0', 15:51:53 INFO - 'HOME': '/home/cltbld', 15:51:53 INFO - 'LANG': 'en_US.UTF-8', 15:51:53 INFO - 'LANGUAGE': 'en_US:en', 15:51:53 INFO - 'LOGNAME': 'cltbld', 15:51:53 INFO - 'MAIL': '/var/mail/cltbld', 15:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:53 INFO - 'MOZ_NO_REMOTE': '1', 15:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:53 INFO - 'NO_EM_RESTART': '1', 15:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:53 INFO - 'PWD': '/builds/slave/test', 15:51:53 INFO - 'SHELL': '/bin/bash', 15:51:53 INFO - 'SHLVL': '1', 15:51:53 INFO - 'TERM': 'linux', 15:51:53 INFO - 'TMOUT': '86400', 15:51:53 INFO - 'USER': 'cltbld', 15:51:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:53 INFO - '_': '/tools/buildbot/bin/python'} 15:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51: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', 'jsonschema'] in /builds/slave/test/build 15:51: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 jsonschema 15:51:53 INFO - Using env: {'DISPLAY': ':0', 15:51:53 INFO - 'HOME': '/home/cltbld', 15:51:53 INFO - 'LANG': 'en_US.UTF-8', 15:51:53 INFO - 'LANGUAGE': 'en_US:en', 15:51:53 INFO - 'LOGNAME': 'cltbld', 15:51:53 INFO - 'MAIL': '/var/mail/cltbld', 15:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:53 INFO - 'MOZ_NO_REMOTE': '1', 15:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:53 INFO - 'NO_EM_RESTART': '1', 15:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:53 INFO - 'PWD': '/builds/slave/test', 15:51:53 INFO - 'SHELL': '/bin/bash', 15:51:53 INFO - 'SHLVL': '1', 15:51:53 INFO - 'TERM': 'linux', 15:51:53 INFO - 'TMOUT': '86400', 15:51:53 INFO - 'USER': 'cltbld', 15:51:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:53 INFO - '_': '/tools/buildbot/bin/python'} 15:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:53 INFO - Downloading/unpacking jsonschema 15:51:53 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 15:51:53 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 15:51:53 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 15:51:53 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 15:51:53 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 15:51:53 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 15:51:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:55 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:56 INFO - warning: no files found matching '*.txt' 15:51:56 INFO - no previously-included directories found matching 'build' 15:51:56 INFO - no previously-included directories found matching 'dist' 15:51:56 INFO - no previously-included directories found matching '.git*' 15:51:56 INFO - Installing collected packages: jsonschema, functools32 15:51:56 INFO - Running setup.py install for functools32 15:51:56 INFO - warning: no files found matching '*.txt' 15:51:56 INFO - no previously-included directories found matching 'build' 15:51:56 INFO - no previously-included directories found matching 'dist' 15:51:56 INFO - no previously-included directories found matching '.git*' 15:51:56 INFO - Successfully installed jsonschema functools32 15:51:56 INFO - Cleaning up... 15:51:56 INFO - Return code: 0 15:51:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf4872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, '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-1464647932.455281-1419684258', '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 15:51: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', 'flake8'] in /builds/slave/test/build 15:51: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 flake8 15:51:56 INFO - Using env: {'DISPLAY': ':0', 15:51:56 INFO - 'HOME': '/home/cltbld', 15:51:56 INFO - 'LANG': 'en_US.UTF-8', 15:51:56 INFO - 'LANGUAGE': 'en_US:en', 15:51:56 INFO - 'LOGNAME': 'cltbld', 15:51:56 INFO - 'MAIL': '/var/mail/cltbld', 15:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:56 INFO - 'MOZ_NO_REMOTE': '1', 15:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:56 INFO - 'NO_EM_RESTART': '1', 15:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:56 INFO - 'PWD': '/builds/slave/test', 15:51:56 INFO - 'SHELL': '/bin/bash', 15:51:56 INFO - 'SHLVL': '1', 15:51:56 INFO - 'TERM': 'linux', 15:51:56 INFO - 'TMOUT': '86400', 15:51:56 INFO - 'USER': 'cltbld', 15:51:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:56 INFO - '_': '/tools/buildbot/bin/python'} 15:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:56 INFO - Downloading/unpacking flake8 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:59 INFO - no previously-included directories found matching 'docs/_build' 15:51:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:59 INFO - Running setup.py install for pep8 15:51:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:59 INFO - no previously-included directories found matching 'docs/_build' 15:51:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:59 INFO - Cleaning up... 15:51:59 INFO - Return code: 0 15:51:59 INFO - Running post-action listener: _resource_record_post_action 15:51:59 INFO - Running post-action listener: _start_resource_monitoring 15:51:59 INFO - Starting resource monitoring. 15:51:59 INFO - ##### 15:51:59 INFO - ##### Running install step. 15:51:59 INFO - ##### 15:51:59 INFO - Running pre-action listener: _resource_record_pre_action 15:51:59 INFO - Running main action method: install 15:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:59 INFO - Reading from file tmpfile_stdout 15:51:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:59 INFO - Reading from file tmpfile_stdout 15:51:59 INFO - Output received: 15:51:59 INFO - Usage: mozinstall [options] installer 15:51:59 INFO - Options: 15:51:59 INFO - -h, --help show this help message and exit 15:51:59 INFO - -d DEST, --destination=DEST 15:51:59 INFO - Directory to install application into. [default: 15:51:59 INFO - "/builds/slave/test"] 15:51:59 INFO - --app=APP Application being installed. [default: firefox] 15:51:59 INFO - mkdir: /builds/slave/test/build/application 15:51:59 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'] 15:51:59 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 15:52:15 INFO - Reading from file tmpfile_stdout 15:52:15 INFO - Output received: 15:52:15 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:15 INFO - Running post-action listener: _resource_record_post_action 15:52:15 INFO - ##### 15:52:15 INFO - ##### Running run-tests step. 15:52:15 INFO - ##### 15:52:15 INFO - Running pre-action listener: _resource_record_pre_action 15:52:15 INFO - Running main action method: run_tests 15:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:15 INFO - Python 2.7.3 15:52:15 INFO - Return code: 0 15:52:15 INFO - grabbing minidump binary from tooltool 15:52:15 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')]} 15:52:15 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 0x15b9410>, '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 0x15ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ba7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:15 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 15:52:15 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 15:52:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:15 INFO - Return code: 0 15:52:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:52:16 INFO - Return code: 0 15:52:16 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/PFkRtY74QaCv8vwtlU479g/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 15:52:16 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/PFkRtY74QaCv8vwtlU479g/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 15:52:16 INFO - Using env: {'DISPLAY': ':0', 15:52:16 INFO - 'HOME': '/home/cltbld', 15:52:16 INFO - 'LANG': 'en_US.UTF-8', 15:52:16 INFO - 'LANGUAGE': 'en_US:en', 15:52:16 INFO - 'LOGNAME': 'cltbld', 15:52:16 INFO - 'MAIL': '/var/mail/cltbld', 15:52:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:16 INFO - 'MOZ_NO_REMOTE': '1', 15:52:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:16 INFO - 'NO_EM_RESTART': '1', 15:52:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:16 INFO - 'PWD': '/builds/slave/test', 15:52:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:16 INFO - 'SHELL': '/bin/bash', 15:52:16 INFO - 'SHLVL': '1', 15:52:16 INFO - 'TERM': 'linux', 15:52:16 INFO - 'TMOUT': '86400', 15:52:16 INFO - 'USER': 'cltbld', 15:52:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464647932.455281-1419684258', 15:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:16 INFO - '_': '/tools/buildbot/bin/python'} 15:52:16 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/PFkRtY74QaCv8vwtlU479g/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 15:52:16 INFO - mozversion application_buildid: 20160530120549 15:52:16 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:52:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:52:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:16 INFO - mozversion application_name: Firefox 15:52:16 INFO - mozversion application_remotingname: firefox-dev 15:52:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:52:16 INFO - mozversion application_vendor: Mozilla 15:52:16 INFO - mozversion application_version: 48.0a2 15:52:16 INFO - mozversion platform_buildid: 20160530120549 15:52:16 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:52:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:52:16 INFO - mozversion platform_version: 48.0a2 15:52:16 INFO - using testdate: 1464648736 15:52:16 INFO - actual date: 1464648736 15:52:16 INFO - starting webserver on 'localhost:37437' 15:52:16 INFO - SUITE-START | Running 2 tests 15:52:16 INFO - TEST-START | dromaeo_css 15:52:16 INFO - operating with platform_type : linux_ 15:52:16 INFO - Initialising browser for dromaeo_css test... 15:52:16 INFO - TEST-INFO | started process 7935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIyq1l/profile http://localhost:37437/getInfo.html) 15:52:20 INFO - PROCESS | 7935 | 15:52:20 INFO - PROCESS | 7935 | (process:8013): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:52:21 INFO - PROCESS | 7935 | __metrics Screen width/height:1600/1200 15:52:21 INFO - PROCESS | 7935 | colorDepth:24 15:52:21 INFO - PROCESS | 7935 | Browser inner width/height: 1024/697 15:52:21 INFO - PROCESS | 7935 | __metrics 15:52:22 ERROR - PROCESS | 7935 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 15:52:22 INFO - TEST-INFO | 7935: exit 0 15:52:22 INFO - Browser initialized. 15:52:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:22 INFO - TEST-INFO | started process 8064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIyq1l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:24 INFO - PROCESS | 8064 | 15:52:24 INFO - PROCESS | 8064 | (process:8131): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:52:34 INFO - PROCESS | 8064 | RSS: Main: 152297472 15:52:34 INFO - PROCESS | 8064 | 15:53:24 INFO - PROCESS | 8064 | 1464648804208 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] 15:55:31 INFO - PROCESS | 8064 | Cycle 1(1): loaded http://localhost:37437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37437/tests/dromaeo/cssquery-ext.html) 15:55:32 INFO - PROCESS | 8064 | RSS: Main: 155942912 15:55:32 INFO - PROCESS | 8064 | 15:58:34 INFO - PROCESS | 8064 | Cycle 1(1): loaded http://localhost:37437/tests/dromaeo/cssquery-ext.html (next: http://localhost:37437/tests/dromaeo/cssquery-jquery.html) 15:58:35 INFO - PROCESS | 8064 | RSS: Main: 153649152 15:58:35 INFO - PROCESS | 8064 | 16:01:37 INFO - PROCESS | 8064 | Cycle 1(1): loaded http://localhost:37437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37437/tests/dromaeo/cssquery-mootools.html) 16:01:37 INFO - PROCESS | 8064 | RSS: Main: 153296896 16:01:37 INFO - PROCESS | 8064 | 16:04:39 INFO - PROCESS | 8064 | Cycle 1(1): loaded http://localhost:37437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37437/tests/dromaeo/cssquery-prototype.html) 16:04:39 INFO - PROCESS | 8064 | RSS: Main: 153223168 16:04:39 INFO - PROCESS | 8064 | 16:07:42 INFO - PROCESS | 8064 | Cycle 1(1): loaded http://localhost:37437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37437/tests/dromaeo/cssquery-yui.html) 16:07:42 INFO - PROCESS | 8064 | RSS: Main: 154607616 16:07:42 INFO - PROCESS | 8064 | 16:10:44 INFO - PROCESS | 8064 | Cycle 1(1): loaded http://localhost:37437/tests/dromaeo/cssquery-yui.html (next: http://localhost:37437/tests/dromaeo/cssquery-dojo.html) 16:10:45 INFO - PROCESS | 8064 | RSS: Main: 156491776 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | __start_tp_report 16:10:45 INFO - PROCESS | 8064 | _x_x_mozilla_page_load 16:10:45 INFO - PROCESS | 8064 | _x_x_mozilla_page_load_details 16:10:45 INFO - PROCESS | 8064 | |i|pagename|runs| 16:10:45 INFO - PROCESS | 8064 | |0;dojo.html;3359.143418428301;3423.760336776426;3458.2910503346816;3488.633693462185;3510.719142468603;5740.79907203248;5746.913796293059;5762.135679648055;5765.6540607563575;5802.5938184327115;5724.4561766632205;5756.194132821408;5783.5084017858535;5794.768209271624;5836.358000619939;5184.896302073957;5214.165733482643;5245.396779370364;5276.3668359796875;5300.310959575249;5093.185090385539;5303.893922121555;5396.568274538027;5405.486478784509;5433.891322173554;5244.134717771563;5248.422673505911;5292.92060619091;5322;5335.973320133394;5250.264962905197;5280.9207861882105;5294.470552944675;5299.178627312773;5299.2845965794895;5114.232865070232;5182.792688292464;5204.661696989683;5218.373795144569;5236.581073514109;5344.091504444254;5578.191162281487;5613.214150019001;5634.549236061105;5736.827895163152;6083.726232319556;6083.939160608382;6110.572259941806;6113;6115.48018418435;6121.908171377433;6134.355892631254;6142.84642883927;6171.197744293258;6174.320824709278;5607.327120745495;5729.1119876419225;5754.4533269339345;5787.421257874221;5802.97098514509;6299.779507717208;6300.558960872695;6302.470855051175;6339.492840572743;6358;5953.868764934648;6066.787662431882;6081.087836824512;6099.84919596061;6132.202813634199;6057.061155520902;6101.816945491642;6114.7840275394365;6118.405988989689;6133.6319820810895;5990.891685038282;6039.245094363205;6046.667433291212;6057.60625559346;6080.817575472743;5899.7050147492455;5936.7031648417405;5963.940360596339;6131.785387511416;6170.660613666201;4612.331211974245;4625;4632.351470794091;4648.697834640738;4650.767461626905;4124.979375103166;4134.524529679125;4141.109661422808;4154.543000269968;4170.562090980464;5862.912056319158;5900.321463031721;5919.615225010447;5948.821535353946;5972.761089556369;5982.581219314693;5994.580379373489;6065.727042283108;6087.147799308012;6275.780347687901;5860.736266868002;5940.168376427304;5948.048312270016;5950.137230101697;5951.702414879239;5120.487951204924;5285.07511185541;5289.550388216968;5315.388730295988;5341.652792568549;6425.228972523327;6445.258795238514;6461.321561236096;6519.902201466982;6523.18460192476;5943.910841337297;6223.315435302113;6272.870883240877;6277.811665650038;6278.654673992792;6276.497880169667;6359.90460143089;6381.521385895983;6401.519886008475;6412.679366031586;6054.061620448838;6069.939300606938;6071.574989750852;6078.209832721895;6087.178230938944;5927.940720592911;6123.069106197319;6148.692565371624;6164.106204600397;6181.721822517908;5899;5925.585209035326;5934.169216309634;5939.910901336397;6022.759089636365;5833.562482813891;5924.348321684525;5946;5951.702414879325;5961.552883533665;5725.227094342211;5797.594168408171;5849.883002339844;5857.209276747755;5951.375105614022;5936.910946335722;5975.342712301556;5988.401159884151;6004.549658775697;6037.184980027816;5861.384554621874;5868.735906884115;5871.178035075008;5881.73532191061;5882.49998750111 16:10:45 INFO - PROCESS | 8064 | |1;ext.html;671.278375746073;690.7168061094952;699.2552931128351;750.264740554257;765.0322342237071;38768.41847372288;39678.60321396785;39753.80123099388;39801.80099099508;39832.80083599578;43329.566704332945;43766.12467750643;44007.119857602826;44051.77974110133;44123.77938110305;8727.781805454866;8924.8661270081;8927.285817134614;8929.46423214606;8930.37487375884;8689.608967596474;8786.868196977019;8788.604512796908;8791.384603077788;8798.428102173339;9013.729588112334;9045.412048216878;9068.410553314014;9083.909160908406;9107.544622768868;8941.329400295004;8947.552622368856;8988.46069235848;9046.185843274137;9050.728478145666;8834.160754728355;8902.24330931865;8923.15230053144;8928.73213803587;8958.820823583557;42965.785171074254;43098.56901431008;43379.783101084606;43443.565564344266;43550.56449435497;2234.7318321801326;4078.6257908124007;4170.291050521419;4228.894277643053;4528.50186479487;33010.504842427385;33127.6687233127;33406;33892.15269618279;34231;4468.262736648449;4539.546045395467;4669.813207471697;4678.485366609671;4681.74250416227;223032;223382;223648.8817555918;225475;226589;38743.612563874;60439.39560604426;61072;61189;61211.69394153001;36837.63162368342;37026.81486592603;37043.62956370402;37217.25565488675;37263.627363726555;15455.149966751937;15805.446809361618;15806.36774529029;15810.36758529669;15828;12439.06706996979;12484.12611117213;12510.311932843599;12510.74978500425;12523.311217882921;9234.307426943005;9317.208037316768;9324.25405967521;9383.390079644802;9399.24806015517;3616.72874534411;3628.8911332660064;3681.7422780405113;3693.2798104369926;3732.6267373263;1172.9706757330964;1227.6378468351857;1265.0764941592504;1292.4571679894466;1292.954746583865;33300;33441.665583344344;33516.329673406886;34075;34333.82833085819;1192.5825960913785;1222.9877701223052;1250.2748405924542;1257.528426839935;1280.6414204022888;15705.528834134995;16339.754903676454;16377.0992595406;16673.166341682867;16816.24326905292;504722;515401;518910;530158;534206;55481;56524.717376413675;56707.43292567104;56960;57150;1490.4559835659907;1566.537871327961;1570.285520088357;1573.3549244809344;1581.5887869153873;30004.549931750604;31024.53463198009;32476;33422.832885835414;33868.32263354769;59458;60593.0911036326;60640.39359606348;60830;60964.39035609765;436141;443841;444143;444223;445412;45849.54150458453;46047.76976115098;46509.76745116388;46576.53423465722;47056.52943470659;51177;51889.740551297;52243.73878130585;52276.21585676142;52644.736776317404;43166.78416607897;43328;43770.12459750851;44490.3326450097;44793.77603111963;43451.78274108609;43792.34311485394;43832;44152;44488.777556112014;44455.55544444514;45069.32396014128;45604.315935261664;46296.53703463057;46506.53493465022;33467.66532334645;34038.14904627404;34227;35824.82087589546;36053.27893442169;28873.85563072171;29024;29329.41341173122;29401.11796646104;29645.40709185761 16:10:45 INFO - PROCESS | 8064 | |2;jquery.html;423.21704846034856;428.60782384118534;432.4594257178527;438.86175854605796;440.12634919684433;18907.432777016693;19480.474041196198;19643;20984.580308393823;21628.459288517755;20176.394708158743;20503.384898453034;20636;20674.586508269826;20696.068676909537;5752.7986520471795;5758.280214973118;5982.132590774335;5987.580869339148;5991.041433370661;5823.534117270629;5884.588078834483;5928.3775203603645;5942.792002279921;5943.3462319144855;5652.180433837091;5880.5883588148845;5893.911591326134;5918;5919.1713160157615;5869.647821130725;5880.911786323209;5897.292324921037;5910.852228694274;5911.704414779244;5317.079238711282;5343.786248550054;5372.409035006146;5388.811391601275;5389.487998640123;13848.792268115987;14650.194239316834;14730.337134828958;23770.524589508284;24069.518609627885;2422.321749910028;2492.8628925409093;2616.738326167387;2670.639463672399;3041.057272245611;9961.90038099617;10588.15294776416;10596.735081622945;10617.57529698811;10948.4525773711;1901.3820508334709;1987.1355960157377;1991.8705284156629;1998.6402447559433;2005.9699104513445;84482;85284.57357713234;87441.12558874393;87681.12318876793;89056.55471722665;11047.392393418279;11181.776364472827;11201;11267.774644507064;11858.762824743457;14617.269136543131;14678.41286348534;14689.853101469062;14704.926475367554;14762.778558321634;8558.700445484377;8657.480551166824;8736.737897863075;8796.47221166732;9106.86339704905;8208.425410221227;8229.506229626242;8242.134575869568;8287.212714792086;8371.539565323965;4599.977000114978;4659.277811939155;4973.651844370932;4993.575546078551;5246.527812496894;2077.2937201351615;2129.3505480828494;2181.6291230490856;2203.823694104468;2245.5172137990085;1026.1944373666786;1128.15388458656;1137.302938862509;1139.2082502660571;1140.2417392434104;19029.333973310866;19085;19150.71273930892;19257.32599359016;19662.311819086262;1092.4810714910354;1107.9279846809932;1131.185546406586;1136.8522092128135;1146.7763786061637;11200.439978001068;11331.660050198507;11356.602518911799;11363.37501437429;11376.146788990858;487480;506081;506132;506715;516637;87821.56089219514;88440.55779721189;88569.55715221382;92151;93945.5302723482;1140.133498541098;1143.845580846575;1161.5992482593492;1186.3701236917148;1223.9143259971895;18408.447746567625;18668.15993280333;18828.6234275311;18893.527661808566;19034.33379831699;41378;42365.78817105895;43601;44143;44765.77617111894;63926.680366597866;64397;64420;64507;64912.35087649063;8947.284217262473;8988.595513201792;9054.456732596065;9189.172974432333;9255.398399104037;8944.642214311354;13964.79052814229;14260.643483912985;14470.565883023526;14801.333939972943;12172.208806427554;12392.380380981096;12546.937265313614;12631.368431578569;12954.870451295366;11562.710932226762;11971.580994665144;11993.880061199276;12350.320732359807;12757.617271481871;12567.434465448894;12751.48994040228;12789.296588687712;12802;13020.088593798344;8858.114188581349;9071.637134514809;9082.091790820865;9097.862767154105;9181.311401644769;12327.93836030814;12342.259464432163;12451.937740311603;12453.1905426147;12466.314352710688 16:10:45 INFO - PROCESS | 8064 | |3;mootools.html;1587.8412158784122;1594.418037416343;1867.6264747050593;1948.581055073159;1979.3072424651364;8101.635426405811;8159.877601835978;8219.794505137375;8248.7937801555;8252.339812814967;7469.813254668622;8343.74968750937;8527.78680532987;8565.40042197045;8578.142185781418;2389.772971567703;2416.4683769570665;2424.284835973392;2427.1626288930293;2430.878456077198;2408.9879550602222;2423.842450240729;2426.623873299641;2442.1330427698176;2453.987730061347;2345.3901985483726;2367.538330025646;2404.0263693204192;2408.421978725111;2425.6725342078857;2411;2416.7220769611545;2418.8669623170717;2430.6961629796365;2457.2505385857307;2436.4030812451065;2438.231956933578;2438.792702620279;2457.1522824625476;2461.9261422157365;8487.787805304917;8553;8587.227149556507;8587.270082043035;8587.570621468902;5271.499207575274;5430.266913966603;5437.157240627709;5447.155690867922;5473.726313684339;3547.7516573839844;3602.5676918769655;3642.653947874948;3686.4101743720876;3693.095191678029;1137.243732917609;1141.7773534160842;1160.5937921727411;1162.1458228202264;1162.5233654201736;12423.62729118128;12462.81305780414;12601.180923240052;12637.49450021998;12644.810327844998;4628.282616194495;4659.906801864012;4705.576498115186;4739.265413860857;4743.217369134054;10691.946540267249;10702.785944281226;10707.250492465608;10715.142788576895;10718.196135289885;5459;5461.044317244467;5461.126219804892;5471.2887324647545;5485.670859748428;4266.104118135227;4729;4750.667453278306;4800.783964721596;5037.143685573461;4246.893827654271;4249.702520823513;4275.40144379787;4278.807453664593;4312.417823593837;1331.507342283342;1344.193483909666;1350.1898860683707;1350.59482155353;1365.7609918264263;1042.1766804224728;1087.260662749338;1093.436880006797;1093.7703082352796;1096.819024860889;6033.5173186145;6119.724612392453;6183.628982261079;6190.442860142519;6263.404976527223;991.5637119667323;1049.7795462952713;1074.2963358999868;1101.0530943388678;1102.8125218712837;4245.490541135084;4298.3552467130185;4331.0904710011255;4332.67504937131;4355.651547876162;9791.559379827924;9840.458774767456;10128.797424051478;10135.695929122137;10175.745606359753;10061.446620435947;10289.53697083633;10383.428911409794;10396.740081498023;10468.842967355497;7966.561839098905;8061.838763224702;8134.511929284262;8174.591270436455;8227;6171.352008039091;6178.969105154445;6241.687915604292;6272.655003974825;6317.873642527215;9201.079892010745;9256.120668536478;9467.857982130412;9508.904910950801;9532;9221;9449.866016078115;9548.092931171528;9748.707538773848;9765.658201962897;6698.899516507159;7056.15326160864;7241.094863142107;7397.112346518452;7563.243675632392;8197.959010204911;8199.057108432607;8208.507489550408;8221.260086592236;8262.958685206535;7232.132144142526;7394.667239974322;7442.665080071518;7537.057867766529;7615.504992175491;7287.344139027513;7433.442491813027;7494.962525187339;7527.397808175223;7535.472516923982;7014.929850701632;7024.438044956289;7030.3321184487395;7048.506604537633;7075.009498670293;5210.296609957607;5301.390340110936;5326.760295786621;5473.972630136983;5499.422560631237;5370.382406023201;5377.166539186433;5475.5072043516275;5525.502704756591;5538.501534861882 16:10:45 INFO - PROCESS | 8064 | |4;prototype.html;356.7306683453992;357.2105646521189;357.7924803613904;358.3370764086439;358.625236627724;6712.295209003058;6779.322067793219;6832.145981752281;6890.862182756342;6905.3094690530925;6647.036179753933;6651.135352404181;6653.101831252779;6656.400923916846;6667.633280169589;4760.404949381336;4900.264960255972;4968.056069346831;5025.547700706936;5067.189249720045;5026.497350264981;5027.0699920514635;5030.5975521958335;5038.143515602356;5062.0888240116765;4973.825916092937;4975.57707594853;4988.4762099979525;4994.200927851544;5008.574271186935;4979.975100124512;4981.427135879384;5000.7249601271915;5000.924986125211;5042.899142017139;4404.515503294635;4425.690201685883;4431.379606855043;4434.578715022068;4441.089576636782;6191.164192834;6389.968050159766;6390.840228994266;6450.322716114787;6459.903101453482;5839.503642190419;5869.266341707286;5871.882562348772;5872;5880.941190588125;7068.151821781367;7081.681324340417;7082.291770822928;7088.220295767462;7103.076600041962;4824.1316563018645;4832.830850920201;4836.46798852126;4846.903061938741;4851.102546028996;7238.09523809529;7317.487775855692;7339.412846972229;7361.116666000061;7393.8521229575645;4927.679700819435;4957.529034741766;4959.355283813081;4965.205567109318;4971.353724015927;4990.226514890198;4999;5002.274670172805;5022.698638081727;5051.368578927634;5766.913496297559;5799.739011744482;5828.417158284223;5833.67914764692;5864.530837532987;7009.719611215596;7058.576485410892;7067.293270672892;7076.540024898365;7100.147982242164;1744.9127543622767;1767.7878654561277;1772.5907903216973;1772.9202185901665;1776.4049043570549;1160.512584714422;1182.6215611004568;1186.833843261944;1190.7856585814463;1191.7259030423052;6861.931380686229;6907.240203577602;6910.101686780687;6916.478374757546;6940.895886561706;7027.543209691354;7165.0685410897295;7329.377002954702;7345.3021962913435;7354.96322518384;6922.688479018456;6980.755673551402;6982.0923279974295;7004.789856304319;7007.264237255014;3986.262541429845;3987.860424885115;4010.037590978144;4013.0569316210667;4013.678905687538;7660;7673.424493163036;7679.078510578766;7692.923070769332;7726.690932362642;7308.342249197598;7442.06974128234;7505.136909255505;7514.9624251878395;7526.548407095592;7657.770266892002;7670.156282808886;7684.346830519356;7689.884651730228;7697.268759467842;7351.41188704913;7377.004104445831;7383.261673832574;7383.446241532014;7384.667689953858;7185.706572816943;7209.6395180241825;7212.963935180291;7247.057882475245;7259.092613423322;7391.260873912565;7584.620768961419;7637.312641862259;7646.617669116411;7732.7680169595005;4791.065742180242;4829.082474329866;4840.491748366511;4852;4877.195262781744;7260.7458738946;7306.305900939402;7336.7798966031105;7355.448341374526;7371.852562948819;7053.470989675692;7094.432445404458;7107.609081500567;7119.466040046914;7135.036770035978;7001.474889383215;7078.823029424306;7107.680154393168;7112.466565007749;7122.394596459359;6928.064711263914;6958.130233720785;6958.512904096665;6974.337437943387;6978.546394484342;7166.784996450115;7181;7186.928130718626;7195.640217989185;7203.423726102004;6791.490638202055;6918.896216556655;6958.443324534126;6968.965155174192;6971.163460384583 16:10:45 INFO - PROCESS | 8064 | |5;yui.html;911.5032307392466;930.702175303903;933.141509810974;934.4673536084431;935.8034812689335;14295.213763243017;14625.92687036566;14634.853651463469;14657.340419681113;14660.78008829867;14572.781408278885;14615.342309596068;14641.707165856677;14654.267286635652;14749.188794616291;755.5731011978243;898.7797989492567;918.6325469812095;922.6078916460511;932.5430539035891;916.7570593792617;920.6961702638147;921.8663293822392;922.4373132389237;924.8936372317169;974.8976357482469;984.8916619171886;986.3588667366233;989.9752506187331;992.354969269973;969.9854502182473;974.3666616699096;977.8826540815112;981.8527220916848;985.1380042462773;725.8258018075677;726.1612837173074;726.4007194064917;726.5204964723257;726.7928640337532;14768.113913165245;14934.62663433412;14954.850451495455;14958.775618365733;14961.102333860003;14963.625909352353;15186.848131518655;15195.772063419057;15456.227188640636;15601.765973510406;11954.924056834927;12075.57735479254;12159.93920030403;12373.319467429288;12378.381080945917;4077.8368865245357;4090.427340172378;4173.457450531411;4284.8500302489265;4293.420388247578;55087.724561376934;55624;56119.43880561224;57415.42584574184;57773.84452310972;10922.1808364373;11116.11071114325;11150.832737508943;11195.328280303207;11363.14776391774;19972.300969466;20071.096800644005;20133.395998119788;20187.899060504602;20197.192112315635;8458.957705211558;8942.211557688488;9003.459792412476;9042.954785226164;9154.954225228832;5085.1355269604255;5095.745212739348;5124.30821839047;5181.4559471255725;5224.373075230997;3608.530890984208;3643.744937854378;3650.908727281839;3657.341678497896;3665.2303016366864;717.2110678253879;741.9629018549051;752.2815710995985;758.3819187362282;764.4037650632515;697.2191145916606;724.807925899637;770.3298130626279;786.4180506425204;789.4553454987181;10033.849492257476;10082.49587520621;10138.138258247984;10159.707714090506;10170.389776613427;664.6709878610119;776.491398134223;782.2099679323924;782.9921700783033;784.5253621558875;4643.44278686553;4722.787474563653;4824.807007719652;4855.732934688626;4868.805247790048;61085.69457152775;61809;63546;66728;67461.66269168623;57544.27367178991;58147.4185258142;59132.70433647804;59305;59972.700136499036;51947.480525195024;53277.93444131096;53866;54161.72919135458;54756.72621636946;9280.58237379306;9301.209397201314;9370.906290937277;9404.529773511435;9508.144267015725;39647.801760992166;40155;40718.1856362877;40779.59220407876;40905.181896362505;45975.77012115052;51307.74346128246;52018.47981520136;52142.47857521376;52284.738576306874;11933.820992684943;11950.940245298718;12044.91595756386;12174.817377739164;12258.264504129424;13504.527341542998;13608.319584020957;13788.172709637454;14025.789613156016;14509.92745036268;11996.520139194334;12371.443285052374;12526.49894004266;12685.175463594836;12913.09608327408;12571.1200215984;12626.179298345578;12703.618891433272;12838.935805320914;12857.742845143232;12397.566085186974;12476.625701228977;12985.740285194432;13004.479820807062;13477.797833032708;10610.681679549625;10744.355338679705;10986.560537578407;10992.505337259683;11029.669109926715;10701.678949631523;10782.353058816496;10867.945660271647;10887.836682449928;10965.725856853642 16:10:45 INFO - PROCESS | 8064 | __end_tp_report 16:10:45 INFO - PROCESS | 8064 | __start_cc_report 16:10:45 INFO - PROCESS | 8064 | _x_x_mozilla_cycle_collect,325 16:10:45 INFO - PROCESS | 8064 | __end_cc_report 16:10:45 INFO - PROCESS | 8064 | __startTimestamp1464649845242__endTimestamp 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | ------- Summary: start ------- 16:10:45 INFO - PROCESS | 8064 | Number of tests: 6 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | [#0] dojo.html Cycles:165 Average:5703.61 Median:5925.59 stddev:635.89 (10.7%) stddev-sans-first:610.66 16:10:45 INFO - PROCESS | 8064 | Values: 3359.1 3423.8 3458.3 3488.6 3510.7 5740.8 5746.9 5762.1 5765.7 5802.6 5724.5 5756.2 5783.5 5794.8 5836.4 5184.9 5214.2 5245.4 5276.4 5300.3 5093.2 5303.9 5396.6 5405.5 5433.9 5244.1 5248.4 5292.9 5322.0 5336.0 5250.3 5280.9 5294.5 5299.2 5299.3 5114.2 5182.8 5204.7 5218.4 5236.6 5344.1 5578.2 5613.2 5634.5 5736.8 6083.7 6083.9 6110.6 6113.0 6115.5 6121.9 6134.4 6142.8 6171.2 6174.3 5607.3 5729.1 5754.5 5787.4 5803.0 6299.8 6300.6 6302.5 6339.5 6358.0 5953.9 6066.8 6081.1 6099.8 6132.2 6057.1 6101.8 6114.8 6118.4 6133.6 5990.9 6039.2 6046.7 6057.6 6080.8 5899.7 5936.7 5963.9 6131.8 6170.7 4612.3 4625.0 4632.4 4648.7 4650.8 4125.0 4134.5 4141.1 4154.5 4170.6 5862.9 5900.3 5919.6 5948.8 5972.8 5982.6 5994.6 6065.7 6087.1 6275.8 5860.7 5940.2 5948.0 5950.1 5951.7 5120.5 5285.1 5289.6 5315.4 5341.7 6425.2 6445.3 6461.3 6519.9 6523.2 5943.9 6223.3 6272.9 6277.8 6278.7 6276.5 6359.9 6381.5 6401.5 6412.7 6054.1 6069.9 6071.6 6078.2 6087.2 5927.9 6123.1 6148.7 6164.1 6181.7 5899.0 5925.6 5934.2 5939.9 6022.8 5833.6 5924.3 5946.0 5951.7 5961.6 5725.2 5797.6 5849.9 5857.2 5951.4 5936.9 5975.3 5988.4 6004.5 6037.2 5861.4 5868.7 5871.2 5881.7 5882.5 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | [#1] ext.html Cycles:180 Average:56555.55 Median:43768.12 stddev:110449.91 (252.4%) stddev-sans-first:110680.06 16:10:45 INFO - PROCESS | 8064 | Values: 671.3 690.7 699.3 750.3 765.0 38768.4 39678.6 39753.8 39801.8 39832.8 43329.6 43766.1 44007.1 44051.8 44123.8 8727.8 8924.9 8927.3 8929.5 8930.4 8689.6 8786.9 8788.6 8791.4 8798.4 9013.7 9045.4 9068.4 9083.9 9107.5 8941.3 8947.6 8988.5 9046.2 9050.7 8834.2 8902.2 8923.2 8928.7 8958.8 42965.8 43098.6 43379.8 43443.6 43550.6 2234.7 4078.6 4170.3 4228.9 4528.5 33010.5 33127.7 33406.0 33892.2 34231.0 4468.3 4539.5 4669.8 4678.5 4681.7 223032.0 223382.0 223648.9 225475.0 226589.0 38743.6 60439.4 61072.0 61189.0 61211.7 36837.6 37026.8 37043.6 37217.3 37263.6 15455.1 15805.4 15806.4 15810.4 15828.0 12439.1 12484.1 12510.3 12510.7 12523.3 9234.3 9317.2 9324.3 9383.4 9399.2 3616.7 3628.9 3681.7 3693.3 3732.6 1173.0 1227.6 1265.1 1292.5 1293.0 33300.0 33441.7 33516.3 34075.0 34333.8 1192.6 1223.0 1250.3 1257.5 1280.6 15705.5 16339.8 16377.1 16673.2 16816.2 504722.0 515401.0 518910.0 530158.0 534206.0 55481.0 56524.7 56707.4 56960.0 57150.0 1490.5 1566.5 1570.3 1573.4 1581.6 30004.5 31024.5 32476.0 33422.8 33868.3 59458.0 60593.1 60640.4 60830.0 60964.4 436141.0 443841.0 444143.0 444223.0 445412.0 45849.5 46047.8 46509.8 46576.5 47056.5 51177.0 51889.7 52243.7 52276.2 52644.7 43166.8 43328.0 43770.1 44490.3 44793.8 43451.8 43792.3 43832.0 44152.0 44488.8 44455.6 45069.3 45604.3 46296.5 46506.5 33467.7 34038.1 34227.0 35824.8 36053.3 28873.9 29024.0 29329.4 29401.1 29645.4 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | [#2] jquery.html Cycles:180 Average:29910.87 Median:13008.02 stddev:83234.52 (639.9%) stddev-sans-first:83438.56 16:10:45 INFO - PROCESS | 8064 | Values: 423.2 428.6 432.5 438.9 440.1 18907.4 19480.5 19643.0 20984.6 21628.5 20176.4 20503.4 20636.0 20674.6 20696.1 5752.8 5758.3 5982.1 5987.6 5991.0 5823.5 5884.6 5928.4 5942.8 5943.3 5652.2 5880.6 5893.9 5918.0 5919.2 5869.6 5880.9 5897.3 5910.9 5911.7 5317.1 5343.8 5372.4 5388.8 5389.5 13848.8 14650.2 14730.3 23770.5 24069.5 2422.3 2492.9 2616.7 2670.6 3041.1 9961.9 10588.2 10596.7 10617.6 10948.5 1901.4 1987.1 1991.9 1998.6 2006.0 84482.0 85284.6 87441.1 87681.1 89056.6 11047.4 11181.8 11201.0 11267.8 11858.8 14617.3 14678.4 14689.9 14704.9 14762.8 8558.7 8657.5 8736.7 8796.5 9106.9 8208.4 8229.5 8242.1 8287.2 8371.5 4600.0 4659.3 4973.7 4993.6 5246.5 2077.3 2129.4 2181.6 2203.8 2245.5 1026.2 1128.2 1137.3 1139.2 1140.2 19029.3 19085.0 19150.7 19257.3 19662.3 1092.5 1107.9 1131.2 1136.9 1146.8 11200.4 11331.7 11356.6 11363.4 11376.1 487480.0 506081.0 506132.0 506715.0 516637.0 87821.6 88440.6 88569.6 92151.0 93945.5 1140.1 1143.8 1161.6 1186.4 1223.9 18408.4 18668.2 18828.6 18893.5 19034.3 41378.0 42365.8 43601.0 44143.0 44765.8 63926.7 64397.0 64420.0 64507.0 64912.4 8947.3 8988.6 9054.5 9189.2 9255.4 8944.6 13964.8 14260.6 14470.6 14801.3 12172.2 12392.4 12546.9 12631.4 12954.9 11562.7 11971.6 11993.9 12350.3 12757.6 12567.4 12751.5 12789.3 12802.0 13020.1 8858.1 9071.6 9082.1 9097.9 9181.3 12327.9 12342.3 12451.9 12453.2 12466.3 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | [#3] mootools.html Cycles:180 Average:5759.22 Median:4918.96 stddev:3112.11 (63.3%) stddev-sans-first:3105.05 16:10:45 INFO - PROCESS | 8064 | Values: 1587.8 1594.4 1867.6 1948.6 1979.3 8101.6 8159.9 8219.8 8248.8 8252.3 7469.8 8343.7 8527.8 8565.4 8578.1 2389.8 2416.5 2424.3 2427.2 2430.9 2409.0 2423.8 2426.6 2442.1 2454.0 2345.4 2367.5 2404.0 2408.4 2425.7 2411.0 2416.7 2418.9 2430.7 2457.3 2436.4 2438.2 2438.8 2457.2 2461.9 8487.8 8553.0 8587.2 8587.3 8587.6 5271.5 5430.3 5437.2 5447.2 5473.7 3547.8 3602.6 3642.7 3686.4 3693.1 1137.2 1141.8 1160.6 1162.1 1162.5 12423.6 12462.8 12601.2 12637.5 12644.8 4628.3 4659.9 4705.6 4739.3 4743.2 10691.9 10702.8 10707.3 10715.1 10718.2 5459.0 5461.0 5461.1 5471.3 5485.7 4266.1 4729.0 4750.7 4800.8 5037.1 4246.9 4249.7 4275.4 4278.8 4312.4 1331.5 1344.2 1350.2 1350.6 1365.8 1042.2 1087.3 1093.4 1093.8 1096.8 6033.5 6119.7 6183.6 6190.4 6263.4 991.6 1049.8 1074.3 1101.1 1102.8 4245.5 4298.4 4331.1 4332.7 4355.7 9791.6 9840.5 10128.8 10135.7 10175.7 10061.4 10289.5 10383.4 10396.7 10468.8 7966.6 8061.8 8134.5 8174.6 8227.0 6171.4 6179.0 6241.7 6272.7 6317.9 9201.1 9256.1 9467.9 9508.9 9532.0 9221.0 9449.9 9548.1 9748.7 9765.7 6698.9 7056.2 7241.1 7397.1 7563.2 8198.0 8199.1 8208.5 8221.3 8263.0 7232.1 7394.7 7442.7 7537.1 7615.5 7287.3 7433.4 7495.0 7527.4 7535.5 7014.9 7024.4 7030.3 7048.5 7075.0 5210.3 5301.4 5326.8 5474.0 5499.4 5370.4 5377.2 5475.5 5525.5 5538.5 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | [#4] prototype.html Cycles:180 Average:5919.61 Median:6898.09 stddev:1814.58 (26.3%) stddev-sans-first:1770.98 16:10:45 INFO - PROCESS | 8064 | Values: 356.7 357.2 357.8 358.3 358.6 6712.3 6779.3 6832.1 6890.9 6905.3 6647.0 6651.1 6653.1 6656.4 6667.6 4760.4 4900.3 4968.1 5025.5 5067.2 5026.5 5027.1 5030.6 5038.1 5062.1 4973.8 4975.6 4988.5 4994.2 5008.6 4980.0 4981.4 5000.7 5000.9 5042.9 4404.5 4425.7 4431.4 4434.6 4441.1 6191.2 6390.0 6390.8 6450.3 6459.9 5839.5 5869.3 5871.9 5872.0 5880.9 7068.2 7081.7 7082.3 7088.2 7103.1 4824.1 4832.8 4836.5 4846.9 4851.1 7238.1 7317.5 7339.4 7361.1 7393.9 4927.7 4957.5 4959.4 4965.2 4971.4 4990.2 4999.0 5002.3 5022.7 5051.4 5766.9 5799.7 5828.4 5833.7 5864.5 7009.7 7058.6 7067.3 7076.5 7100.1 1744.9 1767.8 1772.6 1772.9 1776.4 1160.5 1182.6 1186.8 1190.8 1191.7 6861.9 6907.2 6910.1 6916.5 6940.9 7027.5 7165.1 7329.4 7345.3 7355.0 6922.7 6980.8 6982.1 7004.8 7007.3 3986.3 3987.9 4010.0 4013.1 4013.7 7660.0 7673.4 7679.1 7692.9 7726.7 7308.3 7442.1 7505.1 7515.0 7526.5 7657.8 7670.2 7684.3 7689.9 7697.3 7351.4 7377.0 7383.3 7383.4 7384.7 7185.7 7209.6 7213.0 7247.1 7259.1 7391.3 7584.6 7637.3 7646.6 7732.8 4791.1 4829.1 4840.5 4852.0 4877.2 7260.7 7306.3 7336.8 7355.4 7371.9 7053.5 7094.4 7107.6 7119.5 7135.0 7001.5 7078.8 7107.7 7112.5 7122.4 6928.1 6958.1 6958.5 6974.3 6978.5 7166.8 7181.0 7186.9 7195.6 7203.4 6791.5 6918.9 6958.4 6969.0 6971.2 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - PROCESS | 8064 | [#5] yui.html Cycles:180 Average:15739.38 Median:25309.61 stddev:18239.41 (72.1%) stddev-sans-first:18256.58 16:10:45 INFO - PROCESS | 8064 | Values: 911.5 930.7 933.1 934.5 935.8 14295.2 14625.9 14634.9 14657.3 14660.8 14572.8 14615.3 14641.7 14654.3 14749.2 755.6 898.8 918.6 922.6 932.5 916.8 920.7 921.9 922.4 924.9 974.9 984.9 986.4 990.0 992.4 970.0 974.4 977.9 981.9 985.1 725.8 726.2 726.4 726.5 726.8 14768.1 14934.6 14954.9 14958.8 14961.1 14963.6 15186.8 15195.8 15456.2 15601.8 11954.9 12075.6 12159.9 12373.3 12378.4 4077.8 4090.4 4173.5 4284.9 4293.4 55087.7 55624.0 56119.4 57415.4 57773.8 10922.2 11116.1 11150.8 11195.3 11363.1 19972.3 20071.1 20133.4 20187.9 20197.2 8459.0 8942.2 9003.5 9043.0 9155.0 5085.1 5095.7 5124.3 5181.5 5224.4 3608.5 3643.7 3650.9 3657.3 3665.2 717.2 742.0 752.3 758.4 764.4 697.2 724.8 770.3 786.4 789.5 10033.8 10082.5 10138.1 10159.7 10170.4 664.7 776.5 782.2 783.0 784.5 4643.4 4722.8 4824.8 4855.7 4868.8 61085.7 61809.0 63546.0 66728.0 67461.7 57544.3 58147.4 59132.7 59305.0 59972.7 51947.5 53277.9 53866.0 54161.7 54756.7 9280.6 9301.2 9370.9 9404.5 9508.1 39647.8 40155.0 40718.2 40779.6 40905.2 45975.8 51307.7 52018.5 52142.5 52284.7 11933.8 11950.9 12044.9 12174.8 12258.3 13504.5 13608.3 13788.2 14025.8 14509.9 11996.5 12371.4 12526.5 12685.2 12913.1 12571.1 12626.2 12703.6 12838.9 12857.7 12397.6 12476.6 12985.7 13004.5 13477.8 10610.7 10744.4 10986.6 10992.5 11029.7 10701.7 10782.4 10867.9 10887.8 10965.7 16:10:45 INFO - PROCESS | 8064 | -------- Summary: end -------- 16:10:45 INFO - PROCESS | 8064 | 16:10:45 INFO - TEST-INFO | 8064: exit 0 16:10:45 INFO - TEST-OK | dromaeo_css | took 1109415ms 16:10:45 INFO - TEST-START | kraken 16:10:45 INFO - operating with platform_type : linux_ 16:10:45 INFO - Initialising browser for kraken test... 16:10:45 INFO - TEST-INFO | started process 8306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4oj9xV/profile http://localhost:37437/getInfo.html) 16:10:49 INFO - PROCESS | 8306 | 16:10:49 INFO - PROCESS | 8306 | (process:8385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:10:50 INFO - PROCESS | 8306 | __metrics Screen width/height:1600/1200 16:10:50 INFO - PROCESS | 8306 | colorDepth:24 16:10:50 INFO - PROCESS | 8306 | Browser inner width/height: 1024/697 16:10:50 INFO - PROCESS | 8306 | __metrics 16:10:51 ERROR - PROCESS | 8306 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 16:10:52 INFO - TEST-INFO | 8306: exit 0 16:10:52 INFO - Browser initialized. 16:10:52 INFO - Running cycle 1/1 for kraken test... 16:10:52 INFO - TEST-INFO | started process 8436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4oj9xV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:54 INFO - PROCESS | 8436 | 16:10:54 INFO - PROCESS | 8436 | (process:8507): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:11:04 INFO - PROCESS | 8436 | RSS: Main: 152178688 16:11:04 INFO - PROCESS | 8436 | 16:11:06 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37437/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:07 INFO - PROCESS | 8436 | RSS: Main: 156602368 16:11:07 INFO - PROCESS | 8436 | 16:11:09 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37437/tests/kraken/driver.html?testName=audio-dft) 16:11:10 INFO - PROCESS | 8436 | RSS: Main: 157085696 16:11:10 INFO - PROCESS | 8436 | 16:11:13 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37437/tests/kraken/driver.html?testName=audio-fft) 16:11:14 INFO - PROCESS | 8436 | RSS: Main: 157077504 16:11:14 INFO - PROCESS | 8436 | 16:11:16 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37437/tests/kraken/driver.html?testName=audio-oscillator) 16:11:16 INFO - PROCESS | 8436 | RSS: Main: 157097984 16:11:16 INFO - PROCESS | 8436 | 16:11:18 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:19 INFO - PROCESS | 8436 | RSS: Main: 156786688 16:11:19 INFO - PROCESS | 8436 | 16:11:22 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37437/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:23 INFO - PROCESS | 8436 | RSS: Main: 157224960 16:11:23 INFO - PROCESS | 8436 | 16:11:26 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37437/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:27 INFO - PROCESS | 8436 | RSS: Main: 157044736 16:11:27 INFO - PROCESS | 8436 | 16:11:30 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37437/tests/kraken/driver.html?testName=json-parse-financial) 16:11:30 INFO - PROCESS | 8436 | RSS: Main: 157376512 16:11:30 INFO - PROCESS | 8436 | 16:11:32 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:32 INFO - PROCESS | 8436 | RSS: Main: 157356032 16:11:32 INFO - PROCESS | 8436 | 16:11:34 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:35 INFO - PROCESS | 8436 | RSS: Main: 157376512 16:11:35 INFO - PROCESS | 8436 | 16:11:37 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:37 INFO - PROCESS | 8436 | RSS: Main: 157458432 16:11:37 INFO - PROCESS | 8436 | 16:11:40 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:40 INFO - PROCESS | 8436 | RSS: Main: 158334976 16:11:40 INFO - PROCESS | 8436 | 16:11:43 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:44 INFO - PROCESS | 8436 | RSS: Main: 157806592 16:11:44 INFO - PROCESS | 8436 | 16:11:45 INFO - PROCESS | 8436 | Cycle 1(1): loaded http://localhost:37437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37437/tests/kraken/driver.html?testName=ai-astar) 16:11:46 INFO - PROCESS | 8436 | RSS: Main: 159485952 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | __start_tp_report 16:11:46 INFO - PROCESS | 8436 | _x_x_mozilla_page_load 16:11:46 INFO - PROCESS | 8436 | _x_x_mozilla_page_load_details 16:11:46 INFO - PROCESS | 8436 | |i|pagename|runs| 16:11:46 INFO - PROCESS | 8436 | |0;ai-astar;107;113;104;110;112;112;101;111;113;110 16:11:46 INFO - PROCESS | 8436 | |1;audio-beat-detection;156;126;155;171;129;157;149;127;181;127 16:11:46 INFO - PROCESS | 8436 | |2;audio-dft;164;162;164;163;162;162;163;164;163;163 16:11:46 INFO - PROCESS | 8436 | |3;audio-fft;76;73;75;176;74;77;77;73;177;72 16:11:46 INFO - PROCESS | 8436 | |4;audio-oscillator;92;93;151;93;92;92;141;93;93;138 16:11:46 INFO - PROCESS | 8436 | |5;imaging-gaussian-blur;124;118;118;117;118;117;117;117;116;118 16:11:46 INFO - PROCESS | 8436 | |6;imaging-darkroom;146;148;147;148;146;147;146;147;147;147 16:11:46 INFO - PROCESS | 8436 | |7;imaging-desaturate;95;96;95;95;95;95;96;95;95;95 16:11:46 INFO - PROCESS | 8436 | |8;json-parse-financial;54;58;55;58;55;55;55;74;53;57 16:11:46 INFO - PROCESS | 8436 | |9;json-stringify-tinderbox;56;57;58;56;56;57;57;58;62;57 16:11:46 INFO - PROCESS | 8436 | |10;stanford-crypto-aes;73;73;73;73;75;75;74;79;76;74 16:11:46 INFO - PROCESS | 8436 | |11;stanford-crypto-ccm;119;114;119;122;111;113;115;123;141;128 16:11:46 INFO - PROCESS | 8436 | |12;stanford-crypto-pbkdf2;164;159;158;158;162;163;157;161;160;161 16:11:46 INFO - PROCESS | 8436 | |13;stanford-crypto-sha256-iterative;66;73;68;65;67;68;65;65;65;71 16:11:46 INFO - PROCESS | 8436 | __end_tp_report 16:11:46 INFO - PROCESS | 8436 | __start_cc_report 16:11:46 INFO - PROCESS | 8436 | _x_x_mozilla_cycle_collect,850 16:11:46 INFO - PROCESS | 8436 | __end_cc_report 16:11:46 INFO - PROCESS | 8436 | __startTimestamp1464649906133__endTimestamp 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | ------- Summary: start ------- 16:11:46 INFO - PROCESS | 8436 | Number of tests: 14 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.50 stddev:4.06 (3.6%) stddev-sans-first:4.22 16:11:46 INFO - PROCESS | 8436 | Values: 107.0 113.0 104.0 110.0 112.0 112.0 101.0 111.0 113.0 110.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:155.50 stddev:19.83 (12.8%) stddev-sans-first:20.81 16:11:46 INFO - PROCESS | 8436 | Values: 156.0 126.0 155.0 171.0 129.0 157.0 149.0 127.0 181.0 127.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 16:11:46 INFO - PROCESS | 8436 | Values: 164.0 162.0 164.0 163.0 162.0 162.0 163.0 164.0 163.0 163.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#3] audio-fft Cycles:10 Average:95.00 Median:74.50 stddev:42.99 (57.7%) stddev-sans-first:45.04 16:11:46 INFO - PROCESS | 8436 | Values: 76.0 73.0 75.0 176.0 74.0 77.0 77.0 73.0 177.0 72.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:92.50 stddev:24.73 (26.7%) stddev-sans-first:25.56 16:11:46 INFO - PROCESS | 8436 | Values: 92.0 93.0 151.0 93.0 92.0 92.0 141.0 93.0 93.0 138.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:2.21 (1.9%) stddev-sans-first:0.71 16:11:46 INFO - PROCESS | 8436 | Values: 124.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 116.0 118.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 16:11:46 INFO - PROCESS | 8436 | Values: 146.0 148.0 147.0 148.0 146.0 147.0 146.0 147.0 147.0 147.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:11:46 INFO - PROCESS | 8436 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:6.06 (10.8%) stddev-sans-first:6.30 16:11:46 INFO - PROCESS | 8436 | Values: 54.0 58.0 55.0 58.0 55.0 55.0 55.0 74.0 53.0 57.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.00 stddev:1.78 (3.1%) stddev-sans-first:1.81 16:11:46 INFO - PROCESS | 8436 | Values: 56.0 57.0 58.0 56.0 56.0 57.0 57.0 58.0 62.0 57.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.50 stddev:1.90 (2.6%) stddev-sans-first:1.94 16:11:46 INFO - PROCESS | 8436 | Values: 73.0 73.0 73.0 73.0 75.0 75.0 74.0 79.0 76.0 74.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.50 stddev:8.87 (7.4%) stddev-sans-first:9.39 16:11:46 INFO - PROCESS | 8436 | Values: 119.0 114.0 119.0 122.0 111.0 113.0 115.0 123.0 141.0 128.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:2.31 (1.4%) stddev-sans-first:2.03 16:11:46 INFO - PROCESS | 8436 | Values: 164.0 159.0 158.0 158.0 162.0 163.0 157.0 161.0 160.0 161.0 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - PROCESS | 8436 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.79 (4.1%) stddev-sans-first:2.92 16:11:46 INFO - PROCESS | 8436 | Values: 66.0 73.0 68.0 65.0 67.0 68.0 65.0 65.0 65.0 71.0 16:11:46 INFO - PROCESS | 8436 | -------- Summary: end -------- 16:11:46 INFO - PROCESS | 8436 | 16:11:46 INFO - TEST-INFO | 8436: exit 0 16:11:47 INFO - TEST-OK | kraken | took 61087ms 16:11:47 INFO - SUITE-END | took 1170s 16:11:47 INFO - Completed test suite (00:19:30) 16:11:47 INFO - javascript benchmark 16:11:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.143418428301, 3423.760336776426, 3458.2910503346816, 3488.633693462185, 3510.719142468603, 5740.79907203248, 5746.913796293059, 5762.135679648055, 5765.6540607563575, 5802.5938184327115, 5724.4561766632205, 5756.194132821408, 5783.5084017858535, 5794.768209271624, 5836.358000619939, 5184.896302073957, 5214.165733482643, 5245.396779370364, 5276.3668359796875, 5300.310959575249, 5093.185090385539, 5303.893922121555, 5396.568274538027, 5405.486478784509, 5433.891322173554, 5244.134717771563, 5248.422673505911, 5292.92060619091, 5322.0, 5335.973320133394, 5250.264962905197, 5280.9207861882105, 5294.470552944675, 5299.178627312773, 5299.2845965794895, 5114.232865070232, 5182.792688292464, 5204.661696989683, 5218.373795144569, 5236.581073514109, 5344.091504444254, 5578.191162281487, 5613.214150019001, 5634.549236061105, 5736.827895163152, 6083.726232319556, 6083.939160608382, 6110.572259941806, 6113.0, 6115.48018418435, 6121.908171377433, 6134.355892631254, 6142.84642883927, 6171.197744293258, 6174.320824709278, 5607.327120745495, 5729.1119876419225, 5754.4533269339345, 5787.421257874221, 5802.97098514509, 6299.779507717208, 6300.558960872695, 6302.470855051175, 6339.492840572743, 6358.0, 5953.868764934648, 6066.787662431882, 6081.087836824512, 6099.84919596061, 6132.202813634199, 6057.061155520902, 6101.816945491642, 6114.7840275394365, 6118.405988989689, 6133.6319820810895, 5990.891685038282, 6039.245094363205, 6046.667433291212, 6057.60625559346, 6080.817575472743, 5899.7050147492455, 5936.7031648417405, 5963.940360596339, 6131.785387511416, 6170.660613666201, 4612.331211974245, 4625.0, 4632.351470794091, 4648.697834640738, 4650.767461626905, 4124.979375103166, 4134.524529679125, 4141.109661422808, 4154.543000269968, 4170.562090980464, 5862.912056319158, 5900.321463031721, 5919.615225010447, 5948.821535353946, 5972.761089556369, 5982.581219314693, 5994.580379373489, 6065.727042283108, 6087.147799308012, 6275.780347687901, 5860.736266868002, 5940.168376427304, 5948.048312270016, 5950.137230101697, 5951.702414879239, 5120.487951204924, 5285.07511185541, 5289.550388216968, 5315.388730295988, 5341.652792568549, 6425.228972523327, 6445.258795238514, 6461.321561236096, 6519.902201466982, 6523.18460192476, 5943.910841337297, 6223.315435302113, 6272.870883240877, 6277.811665650038, 6278.654673992792, 6276.497880169667, 6359.90460143089, 6381.521385895983, 6401.519886008475, 6412.679366031586, 6054.061620448838, 6069.939300606938, 6071.574989750852, 6078.209832721895, 6087.178230938944, 5927.940720592911, 6123.069106197319, 6148.692565371624, 6164.106204600397, 6181.721822517908, 5899.0, 5925.585209035326, 5934.169216309634, 5939.910901336397, 6022.759089636365, 5833.562482813891, 5924.348321684525, 5946.0, 5951.702414879325, 5961.552883533665, 5725.227094342211, 5797.594168408171, 5849.883002339844, 5857.209276747755, 5951.375105614022, 5936.910946335722, 5975.342712301556, 5988.401159884151, 6004.549658775697, 6037.184980027816, 5861.384554621874, 5868.735906884115, 5871.178035075008, 5881.73532191061, 5882.49998750111], "value": 5662.141582412124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.278375746073, 690.7168061094952, 699.2552931128351, 750.264740554257, 765.0322342237071, 38768.41847372288, 39678.60321396785, 39753.80123099388, 39801.80099099508, 39832.80083599578, 43329.566704332945, 43766.12467750643, 44007.119857602826, 44051.77974110133, 44123.77938110305, 8727.781805454866, 8924.8661270081, 8927.285817134614, 8929.46423214606, 8930.37487375884, 8689.608967596474, 8786.868196977019, 8788.604512796908, 8791.384603077788, 8798.428102173339, 9013.729588112334, 9045.412048216878, 9068.410553314014, 9083.909160908406, 9107.544622768868, 8941.329400295004, 8947.552622368856, 8988.46069235848, 9046.185843274137, 9050.728478145666, 8834.160754728355, 8902.24330931865, 8923.15230053144, 8928.73213803587, 8958.820823583557, 42965.785171074254, 43098.56901431008, 43379.783101084606, 43443.565564344266, 43550.56449435497, 2234.7318321801326, 4078.6257908124007, 4170.291050521419, 4228.894277643053, 4528.50186479487, 33010.504842427385, 33127.6687233127, 33406.0, 33892.15269618279, 34231.0, 4468.262736648449, 4539.546045395467, 4669.813207471697, 4678.485366609671, 4681.74250416227, 223032.0, 223382.0, 223648.8817555918, 225475.0, 226589.0, 38743.612563874, 60439.39560604426, 61072.0, 61189.0, 61211.69394153001, 36837.63162368342, 37026.81486592603, 37043.62956370402, 37217.25565488675, 37263.627363726555, 15455.149966751937, 15805.446809361618, 15806.36774529029, 15810.36758529669, 15828.0, 12439.06706996979, 12484.12611117213, 12510.311932843599, 12510.74978500425, 12523.311217882921, 9234.307426943005, 9317.208037316768, 9324.25405967521, 9383.390079644802, 9399.24806015517, 3616.72874534411, 3628.8911332660064, 3681.7422780405113, 3693.2798104369926, 3732.6267373263, 1172.9706757330964, 1227.6378468351857, 1265.0764941592504, 1292.4571679894466, 1292.954746583865, 33300.0, 33441.665583344344, 33516.329673406886, 34075.0, 34333.82833085819, 1192.5825960913785, 1222.9877701223052, 1250.2748405924542, 1257.528426839935, 1280.6414204022888, 15705.528834134995, 16339.754903676454, 16377.0992595406, 16673.166341682867, 16816.24326905292, 504722.0, 515401.0, 518910.0, 530158.0, 534206.0, 55481.0, 56524.717376413675, 56707.43292567104, 56960.0, 57150.0, 1490.4559835659907, 1566.537871327961, 1570.285520088357, 1573.3549244809344, 1581.5887869153873, 30004.549931750604, 31024.53463198009, 32476.0, 33422.832885835414, 33868.32263354769, 59458.0, 60593.0911036326, 60640.39359606348, 60830.0, 60964.39035609765, 436141.0, 443841.0, 444143.0, 444223.0, 445412.0, 45849.54150458453, 46047.76976115098, 46509.76745116388, 46576.53423465722, 47056.52943470659, 51177.0, 51889.740551297, 52243.73878130585, 52276.21585676142, 52644.736776317404, 43166.78416607897, 43328.0, 43770.12459750851, 44490.3326450097, 44793.77603111963, 43451.78274108609, 43792.34311485394, 43832.0, 44152.0, 44488.777556112014, 44455.55544444514, 45069.32396014128, 45604.315935261664, 46296.53703463057, 46506.53493465022, 33467.66532334645, 34038.14904627404, 34227.0, 35824.82087589546, 36053.27893442169, 28873.85563072171, 29024.0, 29329.41341173122, 29401.11796646104, 29645.40709185761], "value": 19728.840427044815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.21704846034856, 428.60782384118534, 432.4594257178527, 438.86175854605796, 440.12634919684433, 18907.432777016693, 19480.474041196198, 19643.0, 20984.580308393823, 21628.459288517755, 20176.394708158743, 20503.384898453034, 20636.0, 20674.586508269826, 20696.068676909537, 5752.7986520471795, 5758.280214973118, 5982.132590774335, 5987.580869339148, 5991.041433370661, 5823.534117270629, 5884.588078834483, 5928.3775203603645, 5942.792002279921, 5943.3462319144855, 5652.180433837091, 5880.5883588148845, 5893.911591326134, 5918.0, 5919.1713160157615, 5869.647821130725, 5880.911786323209, 5897.292324921037, 5910.852228694274, 5911.704414779244, 5317.079238711282, 5343.786248550054, 5372.409035006146, 5388.811391601275, 5389.487998640123, 13848.792268115987, 14650.194239316834, 14730.337134828958, 23770.524589508284, 24069.518609627885, 2422.321749910028, 2492.8628925409093, 2616.738326167387, 2670.639463672399, 3041.057272245611, 9961.90038099617, 10588.15294776416, 10596.735081622945, 10617.57529698811, 10948.4525773711, 1901.3820508334709, 1987.1355960157377, 1991.8705284156629, 1998.6402447559433, 2005.9699104513445, 84482.0, 85284.57357713234, 87441.12558874393, 87681.12318876793, 89056.55471722665, 11047.392393418279, 11181.776364472827, 11201.0, 11267.774644507064, 11858.762824743457, 14617.269136543131, 14678.41286348534, 14689.853101469062, 14704.926475367554, 14762.778558321634, 8558.700445484377, 8657.480551166824, 8736.737897863075, 8796.47221166732, 9106.86339704905, 8208.425410221227, 8229.506229626242, 8242.134575869568, 8287.212714792086, 8371.539565323965, 4599.977000114978, 4659.277811939155, 4973.651844370932, 4993.575546078551, 5246.527812496894, 2077.2937201351615, 2129.3505480828494, 2181.6291230490856, 2203.823694104468, 2245.5172137990085, 1026.1944373666786, 1128.15388458656, 1137.302938862509, 1139.2082502660571, 1140.2417392434104, 19029.333973310866, 19085.0, 19150.71273930892, 19257.32599359016, 19662.311819086262, 1092.4810714910354, 1107.9279846809932, 1131.185546406586, 1136.8522092128135, 1146.7763786061637, 11200.439978001068, 11331.660050198507, 11356.602518911799, 11363.37501437429, 11376.146788990858, 487480.0, 506081.0, 506132.0, 506715.0, 516637.0, 87821.56089219514, 88440.55779721189, 88569.55715221382, 92151.0, 93945.5302723482, 1140.133498541098, 1143.845580846575, 1161.5992482593492, 1186.3701236917148, 1223.9143259971895, 18408.447746567625, 18668.15993280333, 18828.6234275311, 18893.527661808566, 19034.33379831699, 41378.0, 42365.78817105895, 43601.0, 44143.0, 44765.77617111894, 63926.680366597866, 64397.0, 64420.0, 64507.0, 64912.35087649063, 8947.284217262473, 8988.595513201792, 9054.456732596065, 9189.172974432333, 9255.398399104037, 8944.642214311354, 13964.79052814229, 14260.643483912985, 14470.565883023526, 14801.333939972943, 12172.208806427554, 12392.380380981096, 12546.937265313614, 12631.368431578569, 12954.870451295366, 11562.710932226762, 11971.580994665144, 11993.880061199276, 12350.320732359807, 12757.617271481871, 12567.434465448894, 12751.48994040228, 12789.296588687712, 12802.0, 13020.088593798344, 8858.114188581349, 9071.637134514809, 9082.091790820865, 9097.862767154105, 9181.311401644769, 12327.93836030814, 12342.259464432163, 12451.937740311603, 12453.1905426147, 12466.314352710688], "value": 9631.648015802248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1587.8412158784122, 1594.418037416343, 1867.6264747050593, 1948.581055073159, 1979.3072424651364, 8101.635426405811, 8159.877601835978, 8219.794505137375, 8248.7937801555, 8252.339812814967, 7469.813254668622, 8343.74968750937, 8527.78680532987, 8565.40042197045, 8578.142185781418, 2389.772971567703, 2416.4683769570665, 2424.284835973392, 2427.1626288930293, 2430.878456077198, 2408.9879550602222, 2423.842450240729, 2426.623873299641, 2442.1330427698176, 2453.987730061347, 2345.3901985483726, 2367.538330025646, 2404.0263693204192, 2408.421978725111, 2425.6725342078857, 2411.0, 2416.7220769611545, 2418.8669623170717, 2430.6961629796365, 2457.2505385857307, 2436.4030812451065, 2438.231956933578, 2438.792702620279, 2457.1522824625476, 2461.9261422157365, 8487.787805304917, 8553.0, 8587.227149556507, 8587.270082043035, 8587.570621468902, 5271.499207575274, 5430.266913966603, 5437.157240627709, 5447.155690867922, 5473.726313684339, 3547.7516573839844, 3602.5676918769655, 3642.653947874948, 3686.4101743720876, 3693.095191678029, 1137.243732917609, 1141.7773534160842, 1160.5937921727411, 1162.1458228202264, 1162.5233654201736, 12423.62729118128, 12462.81305780414, 12601.180923240052, 12637.49450021998, 12644.810327844998, 4628.282616194495, 4659.906801864012, 4705.576498115186, 4739.265413860857, 4743.217369134054, 10691.946540267249, 10702.785944281226, 10707.250492465608, 10715.142788576895, 10718.196135289885, 5459.0, 5461.044317244467, 5461.126219804892, 5471.2887324647545, 5485.670859748428, 4266.104118135227, 4729.0, 4750.667453278306, 4800.783964721596, 5037.143685573461, 4246.893827654271, 4249.702520823513, 4275.40144379787, 4278.807453664593, 4312.417823593837, 1331.507342283342, 1344.193483909666, 1350.1898860683707, 1350.59482155353, 1365.7609918264263, 1042.1766804224728, 1087.260662749338, 1093.436880006797, 1093.7703082352796, 1096.819024860889, 6033.5173186145, 6119.724612392453, 6183.628982261079, 6190.442860142519, 6263.404976527223, 991.5637119667323, 1049.7795462952713, 1074.2963358999868, 1101.0530943388678, 1102.8125218712837, 4245.490541135084, 4298.3552467130185, 4331.0904710011255, 4332.67504937131, 4355.651547876162, 9791.559379827924, 9840.458774767456, 10128.797424051478, 10135.695929122137, 10175.745606359753, 10061.446620435947, 10289.53697083633, 10383.428911409794, 10396.740081498023, 10468.842967355497, 7966.561839098905, 8061.838763224702, 8134.511929284262, 8174.591270436455, 8227.0, 6171.352008039091, 6178.969105154445, 6241.687915604292, 6272.655003974825, 6317.873642527215, 9201.079892010745, 9256.120668536478, 9467.857982130412, 9508.904910950801, 9532.0, 9221.0, 9449.866016078115, 9548.092931171528, 9748.707538773848, 9765.658201962897, 6698.899516507159, 7056.15326160864, 7241.094863142107, 7397.112346518452, 7563.243675632392, 8197.959010204911, 8199.057108432607, 8208.507489550408, 8221.260086592236, 8262.958685206535, 7232.132144142526, 7394.667239974322, 7442.665080071518, 7537.057867766529, 7615.504992175491, 7287.344139027513, 7433.442491813027, 7494.962525187339, 7527.397808175223, 7535.472516923982, 7014.929850701632, 7024.438044956289, 7030.3321184487395, 7048.506604537633, 7075.009498670293, 5210.296609957607, 5301.390340110936, 5326.760295786621, 5473.972630136983, 5499.422560631237, 5370.382406023201, 5377.166539186433, 5475.5072043516275, 5525.502704756591, 5538.501534861882], "value": 4718.099846281794, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7306683453992, 357.2105646521189, 357.7924803613904, 358.3370764086439, 358.625236627724, 6712.295209003058, 6779.322067793219, 6832.145981752281, 6890.862182756342, 6905.3094690530925, 6647.036179753933, 6651.135352404181, 6653.101831252779, 6656.400923916846, 6667.633280169589, 4760.404949381336, 4900.264960255972, 4968.056069346831, 5025.547700706936, 5067.189249720045, 5026.497350264981, 5027.0699920514635, 5030.5975521958335, 5038.143515602356, 5062.0888240116765, 4973.825916092937, 4975.57707594853, 4988.4762099979525, 4994.200927851544, 5008.574271186935, 4979.975100124512, 4981.427135879384, 5000.7249601271915, 5000.924986125211, 5042.899142017139, 4404.515503294635, 4425.690201685883, 4431.379606855043, 4434.578715022068, 4441.089576636782, 6191.164192834, 6389.968050159766, 6390.840228994266, 6450.322716114787, 6459.903101453482, 5839.503642190419, 5869.266341707286, 5871.882562348772, 5872.0, 5880.941190588125, 7068.151821781367, 7081.681324340417, 7082.291770822928, 7088.220295767462, 7103.076600041962, 4824.1316563018645, 4832.830850920201, 4836.46798852126, 4846.903061938741, 4851.102546028996, 7238.09523809529, 7317.487775855692, 7339.412846972229, 7361.116666000061, 7393.8521229575645, 4927.679700819435, 4957.529034741766, 4959.355283813081, 4965.205567109318, 4971.353724015927, 4990.226514890198, 4999.0, 5002.274670172805, 5022.698638081727, 5051.368578927634, 5766.913496297559, 5799.739011744482, 5828.417158284223, 5833.67914764692, 5864.530837532987, 7009.719611215596, 7058.576485410892, 7067.293270672892, 7076.540024898365, 7100.147982242164, 1744.9127543622767, 1767.7878654561277, 1772.5907903216973, 1772.9202185901665, 1776.4049043570549, 1160.512584714422, 1182.6215611004568, 1186.833843261944, 1190.7856585814463, 1191.7259030423052, 6861.931380686229, 6907.240203577602, 6910.101686780687, 6916.478374757546, 6940.895886561706, 7027.543209691354, 7165.0685410897295, 7329.377002954702, 7345.3021962913435, 7354.96322518384, 6922.688479018456, 6980.755673551402, 6982.0923279974295, 7004.789856304319, 7007.264237255014, 3986.262541429845, 3987.860424885115, 4010.037590978144, 4013.0569316210667, 4013.678905687538, 7660.0, 7673.424493163036, 7679.078510578766, 7692.923070769332, 7726.690932362642, 7308.342249197598, 7442.06974128234, 7505.136909255505, 7514.9624251878395, 7526.548407095592, 7657.770266892002, 7670.156282808886, 7684.346830519356, 7689.884651730228, 7697.268759467842, 7351.41188704913, 7377.004104445831, 7383.261673832574, 7383.446241532014, 7384.667689953858, 7185.706572816943, 7209.6395180241825, 7212.963935180291, 7247.057882475245, 7259.092613423322, 7391.260873912565, 7584.620768961419, 7637.312641862259, 7646.617669116411, 7732.7680169595005, 4791.065742180242, 4829.082474329866, 4840.491748366511, 4852.0, 4877.195262781744, 7260.7458738946, 7306.305900939402, 7336.7798966031105, 7355.448341374526, 7371.852562948819, 7053.470989675692, 7094.432445404458, 7107.609081500567, 7119.466040046914, 7135.036770035978, 7001.474889383215, 7078.823029424306, 7107.680154393168, 7112.466565007749, 7122.394596459359, 6928.064711263914, 6958.130233720785, 6958.512904096665, 6974.337437943387, 6978.546394484342, 7166.784996450115, 7181.0, 7186.928130718626, 7195.640217989185, 7203.423726102004, 6791.490638202055, 6918.896216556655, 6958.443324534126, 6968.965155174192, 6971.163460384583], "value": 5322.649191631362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.5032307392466, 930.702175303903, 933.141509810974, 934.4673536084431, 935.8034812689335, 14295.213763243017, 14625.92687036566, 14634.853651463469, 14657.340419681113, 14660.78008829867, 14572.781408278885, 14615.342309596068, 14641.707165856677, 14654.267286635652, 14749.188794616291, 755.5731011978243, 898.7797989492567, 918.6325469812095, 922.6078916460511, 932.5430539035891, 916.7570593792617, 920.6961702638147, 921.8663293822392, 922.4373132389237, 924.8936372317169, 974.8976357482469, 984.8916619171886, 986.3588667366233, 989.9752506187331, 992.354969269973, 969.9854502182473, 974.3666616699096, 977.8826540815112, 981.8527220916848, 985.1380042462773, 725.8258018075677, 726.1612837173074, 726.4007194064917, 726.5204964723257, 726.7928640337532, 14768.113913165245, 14934.62663433412, 14954.850451495455, 14958.775618365733, 14961.102333860003, 14963.625909352353, 15186.848131518655, 15195.772063419057, 15456.227188640636, 15601.765973510406, 11954.924056834927, 12075.57735479254, 12159.93920030403, 12373.319467429288, 12378.381080945917, 4077.8368865245357, 4090.427340172378, 4173.457450531411, 4284.8500302489265, 4293.420388247578, 55087.724561376934, 55624.0, 56119.43880561224, 57415.42584574184, 57773.84452310972, 10922.1808364373, 11116.11071114325, 11150.832737508943, 11195.328280303207, 11363.14776391774, 19972.300969466, 20071.096800644005, 20133.395998119788, 20187.899060504602, 20197.192112315635, 8458.957705211558, 8942.211557688488, 9003.459792412476, 9042.954785226164, 9154.954225228832, 5085.1355269604255, 5095.745212739348, 5124.30821839047, 5181.4559471255725, 5224.373075230997, 3608.530890984208, 3643.744937854378, 3650.908727281839, 3657.341678497896, 3665.2303016366864, 717.2110678253879, 741.9629018549051, 752.2815710995985, 758.3819187362282, 764.4037650632515, 697.2191145916606, 724.807925899637, 770.3298130626279, 786.4180506425204, 789.4553454987181, 10033.849492257476, 10082.49587520621, 10138.138258247984, 10159.707714090506, 10170.389776613427, 664.6709878610119, 776.491398134223, 782.2099679323924, 782.9921700783033, 784.5253621558875, 4643.44278686553, 4722.787474563653, 4824.807007719652, 4855.732934688626, 4868.805247790048, 61085.69457152775, 61809.0, 63546.0, 66728.0, 67461.66269168623, 57544.27367178991, 58147.4185258142, 59132.70433647804, 59305.0, 59972.700136499036, 51947.480525195024, 53277.93444131096, 53866.0, 54161.72919135458, 54756.72621636946, 9280.58237379306, 9301.209397201314, 9370.906290937277, 9404.529773511435, 9508.144267015725, 39647.801760992166, 40155.0, 40718.1856362877, 40779.59220407876, 40905.181896362505, 45975.77012115052, 51307.74346128246, 52018.47981520136, 52142.47857521376, 52284.738576306874, 11933.820992684943, 11950.940245298718, 12044.91595756386, 12174.817377739164, 12258.264504129424, 13504.527341542998, 13608.319584020957, 13788.172709637454, 14025.789613156016, 14509.92745036268, 11996.520139194334, 12371.443285052374, 12526.49894004266, 12685.175463594836, 12913.09608327408, 12571.1200215984, 12626.179298345578, 12703.618891433272, 12838.935805320914, 12857.742845143232, 12397.566085186974, 12476.625701228977, 12985.740285194432, 13004.479820807062, 13477.797833032708, 10610.681679549625, 10744.355338679705, 10986.560537578407, 10992.505337259683, 11029.669109926715, 10701.678949631523, 10782.353058816496, 10867.945660271647, 10887.836682449928, 10965.725856853642], "value": 7244.285777810707, "unit": "score"}], "name": "dromaeo_css", "value": 7619.938667797193, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 104.0, 110.0, 112.0, 112.0, 101.0, 111.0, 113.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 155.0, 171.0, 129.0, 157.0, 149.0, 127.0, 181.0, 127.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 163.0, 162.0, 162.0, 163.0, 164.0, 163.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 75.0, 176.0, 74.0, 77.0, 77.0, 73.0, 177.0, 72.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 151.0, 93.0, 92.0, 92.0, 141.0, 93.0, 93.0, 138.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 58.0, 55.0, 55.0, 55.0, 74.0, 53.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 56.0, 56.0, 57.0, 57.0, 58.0, 62.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 75.0, 75.0, 74.0, 79.0, 76.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 119.0, 122.0, 111.0, 113.0, 115.0, 123.0, 141.0, 128.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 158.0, 158.0, 162.0, 163.0, 157.0, 161.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 68.0, 65.0, 67.0, 68.0, 65.0, 65.0, 65.0, 71.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1520.4, "alertThreshold": 2.0}]} 16:11:47 INFO - Return code: 0 16:11:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:47 ERROR - # TBPL SUCCESS # 16:11:47 INFO - Running post-action listener: _resource_record_post_action 16:11:47 INFO - Running post-run listener: _resource_record_post_run 16:11:48 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497553408; Read time: 16; Write time: 451176 16:11:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248754176; Read time: 0; Write time: 295736 16:11:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248201216; Read time: 16; Write time: 155440 16:11:48 INFO - Running post-run listener: _upload_blobber_files 16:11:48 INFO - Blob upload gear active. 16:11:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:11:48 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:50 INFO - (blobuploader) - INFO - Done attempting. 16:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:50 INFO - (blobuploader) - INFO - Done attempting. 16:11:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:50 INFO - Return code: 0 16:11:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/180003ca636208987960d861c639900f0c203a7dd92c867e65f1616939e76bc03798aa47958ae3437e8d2f25e13a0e3a4853bc1792d65f63228fc563937cc4fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51e58aabee9597d3ce6c305b591971557f6242c9e6834e6c53a186a88652e3806355845651ca3cd3375fa1e2a7f4b48c2a8a75ecd5f65831cc20bf9675ea1126"} 16:11:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:50 INFO - Contents: 16:11:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/180003ca636208987960d861c639900f0c203a7dd92c867e65f1616939e76bc03798aa47958ae3437e8d2f25e13a0e3a4853bc1792d65f63228fc563937cc4fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51e58aabee9597d3ce6c305b591971557f6242c9e6834e6c53a186a88652e3806355845651ca3cd3375fa1e2a7f4b48c2a8a75ecd5f65831cc20bf9675ea1126"} 16:11:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:50 INFO - Copying logs to upload dir... 16:11:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.717733 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-30 16:11:50.514518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:50.518155) ========= 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-1464647932.455281-1419684258 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/180003ca636208987960d861c639900f0c203a7dd92c867e65f1616939e76bc03798aa47958ae3437e8d2f25e13a0e3a4853bc1792d65f63228fc563937cc4fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51e58aabee9597d3ce6c305b591971557f6242c9e6834e6c53a186a88652e3806355845651ca3cd3375fa1e2a7f4b48c2a8a75ecd5f65831cc20bf9675ea1126"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/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/180003ca636208987960d861c639900f0c203a7dd92c867e65f1616939e76bc03798aa47958ae3437e8d2f25e13a0e3a4853bc1792d65f63228fc563937cc4fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51e58aabee9597d3ce6c305b591971557f6242c9e6834e6c53a186a88652e3806355845651ca3cd3375fa1e2a7f4b48c2a8a75ecd5f65831cc20bf9675ea1126"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:50.544236) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:50.544644) ========= 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-1464647932.455281-1419684258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:50.629657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:50.629999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:50.630324) ========= ========= Total master_lag: 0.17 =========